builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1454599615.28 results: success (0) buildid: 20160204050228 builduid: 7a138ba0797a4e31a1429fb139d1f53a revision: 060086e4af2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.276943) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.277435) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.277727) ========= 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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.302290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.302605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.315849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.316244) ========= 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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.365263) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.365576) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.365928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.366234) ========= 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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-04 07:26:55-- 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% 64.2M=0s 2016-02-04 07:26:55 (64.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.475606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.475915) ========= 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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020466 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.527900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:55.528220) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 060086e4af2e --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 060086e4af2e --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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-04 07:26:55,582 Setting DEBUG logging. 2016-02-04 07:26:55,582 attempt 1/10 2016-02-04 07:26:55,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/060086e4af2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 07:26:55,840 unpacking tar archive at: mozilla-beta-060086e4af2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570172 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:56.111602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:56.111937) ========= echo 060086e4af2e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'060086e4af2e'] 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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 060086e4af2e program finished with exit code 0 elapsedTime=0.004628 script_repo_revision: '060086e4af2e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:56.163325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:56.163650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 07:26:56.174473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-04 07:26:56.174866) ========= /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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:26:56 INFO - MultiFileLogger online at 20160204 07:26:56 in /builds/slave/test-pgo 07:26:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:26:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:26:56 INFO - {'append_to_log': False, 07:26:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:26:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:26:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:26:56 INFO - 'branch': 'Mozilla-Beta', 07:26:56 INFO - 'buildbot_json_path': 'buildprops.json', 07:26:56 INFO - 'config_files': ('talos/linux_config.py',), 07:26:56 INFO - 'default_actions': ('clobber', 07:26:56 INFO - 'read-buildbot-config', 07:26:56 INFO - 'download-and-extract', 07:26:56 INFO - 'populate-webroot', 07:26:56 INFO - 'create-virtualenv', 07:26:56 INFO - 'install', 07:26:56 INFO - 'run-tests'), 07:26:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:26:56 INFO - 'download_minidump_stackwalk': True, 07:26:56 INFO - 'download_symbols': 'ondemand', 07:26:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:26:56 INFO - 'tooltool.py': '/tools/tooltool.py', 07:26:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:26:56 INFO - '/tools/misc-python/virtualenv.py')}, 07:26:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:26:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:26:56 INFO - 'installer_path': 'installer.exe', 07:26:56 INFO - 'log_level': 'info', 07:26:56 INFO - 'log_name': 'talos', 07:26:56 INFO - 'log_to_console': True, 07:26:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:26:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:26:56 INFO - 'opt_config_files': (), 07:26:56 INFO - 'pip_index': False, 07:26:56 INFO - 'sps_profile': False, 07:26:56 INFO - 'sps_profile_interval': 0, 07:26:56 INFO - 'suite': 'dromaeojs', 07:26:56 INFO - 'system_bits': '32', 07:26:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:26:56 INFO - 'title': 'talos-linux64-ix-015', 07:26:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:26:56 INFO - 'use_talos_json': True, 07:26:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:26:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:26:56 INFO - 'work_dir': 'build'} 07:26:56 INFO - ##### 07:26:56 INFO - ##### Running clobber step. 07:26:56 INFO - ##### 07:26:56 INFO - Running pre-action listener: _resource_record_pre_action 07:26:56 INFO - Running main action method: clobber 07:26:56 INFO - rmtree: /builds/slave/test-pgo/build 07:26:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:26:56 INFO - Running post-action listener: _resource_record_post_action 07:26:56 INFO - ##### 07:26:56 INFO - ##### Running read-buildbot-config step. 07:26:56 INFO - ##### 07:26:56 INFO - Running pre-action listener: _resource_record_pre_action 07:26:56 INFO - Running main action method: read_buildbot_config 07:26:56 INFO - Using buildbot properties: 07:26:56 INFO - { 07:26:56 INFO - "properties": { 07:26:56 INFO - "buildnumber": 68, 07:26:56 INFO - "product": "firefox", 07:26:56 INFO - "script_repo_revision": "production", 07:26:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:26:56 INFO - "repository": "", 07:26:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 07:26:56 INFO - "buildid": "20160204050228", 07:26:56 INFO - "slavename": "talos-linux64-ix-015", 07:26:56 INFO - "pgo_build": "True", 07:26:56 INFO - "basedir": "/builds/slave/test-pgo", 07:26:56 INFO - "project": "", 07:26:56 INFO - "platform": "ubuntu64_hw", 07:26:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:26:56 INFO - "slavebuilddir": "test", 07:26:56 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 07:26:56 INFO - "branch": "mozilla-beta", 07:26:56 INFO - "repo_path": "releases/mozilla-beta", 07:26:56 INFO - "stage_platform": "linux64-pgo", 07:26:56 INFO - "builduid": "7a138ba0797a4e31a1429fb139d1f53a", 07:26:56 INFO - "revision": "060086e4af2e" 07:26:56 INFO - }, 07:26:56 INFO - "sourcestamp": { 07:26:56 INFO - "repository": "", 07:26:56 INFO - "hasPatch": false, 07:26:56 INFO - "project": "", 07:26:56 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 07:26:56 INFO - "changes": [ 07:26:56 INFO - { 07:26:56 INFO - "category": null, 07:26:56 INFO - "files": [ 07:26:56 INFO - { 07:26:56 INFO - "url": null, 07:26:56 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2" 07:26:56 INFO - } 07:26:56 INFO - ], 07:26:56 INFO - "repository": "", 07:26:56 INFO - "rev": "060086e4af2e", 07:26:56 INFO - "who": "sendchange", 07:26:56 INFO - "when": 1454599589, 07:26:56 INFO - "number": 7563176, 07:26:56 INFO - "comments": "Bug 1244693 - On Beta/Release channels, allow OpenType Layout tables (GDEF/GPOS/GSUB) to pass through OTS unchecked, relying on harfbuzz to handle them safely. r=jdaggett a=sledru", 07:26:56 INFO - "project": "", 07:26:56 INFO - "at": "Thu 04 Feb 2016 07:26:29", 07:26:56 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 07:26:56 INFO - "revlink": "", 07:26:56 INFO - "properties": [ 07:26:56 INFO - [ 07:26:56 INFO - "buildid", 07:26:56 INFO - "20160204050228", 07:26:56 INFO - "Change" 07:26:56 INFO - ], 07:26:56 INFO - [ 07:26:56 INFO - "builduid", 07:26:56 INFO - "7a138ba0797a4e31a1429fb139d1f53a", 07:26:56 INFO - "Change" 07:26:56 INFO - ], 07:26:56 INFO - [ 07:26:56 INFO - "pgo_build", 07:26:56 INFO - "True", 07:26:56 INFO - "Change" 07:26:56 INFO - ] 07:26:56 INFO - ], 07:26:56 INFO - "revision": "060086e4af2e" 07:26:56 INFO - } 07:26:56 INFO - ], 07:26:56 INFO - "revision": "060086e4af2e" 07:26:56 INFO - } 07:26:56 INFO - } 07:26:56 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2. 07:26:56 INFO - Running post-action listener: _resource_record_post_action 07:26:56 INFO - ##### 07:26:56 INFO - ##### Running download-and-extract step. 07:26:56 INFO - ##### 07:26:56 INFO - Running pre-action listener: _resource_record_pre_action 07:26:56 INFO - Running main action method: download_and_extract 07:26:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:26: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')]} 07:26:56 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/test_packages.json 07:26:56 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:26:56 INFO - Downloaded 1270 bytes. 07:26:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:26:56 INFO - Using the following test package requirements: 07:26:56 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 07:26:56 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:26:56 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 07:26:56 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:26:56 INFO - u'jsshell-linux-x86_64.zip'], 07:26:56 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:26:56 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 07:26:56 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 07:26:56 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:26:56 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 07:26:56 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:26:56 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 07:26:56 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:26:56 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 07:26:56 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 07:26:56 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:26:56 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 07:26:56 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:26: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')]} 07:26:56 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:26:56 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:26:57 INFO - Downloaded 21580268 bytes. 07:26:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:26:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:26:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:26:58 INFO - Return code: 0 07:26:58 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:26: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')]} 07:26:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:26:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:26:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:26:58 INFO - Downloaded 21580268 bytes. 07:26:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:26:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:26:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:26:59 INFO - Return code: 0 07:26:59 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')]} 07:26:59 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 07:26:59 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 07:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:27:02 INFO - Downloaded 11132038 bytes. 07:27:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:27:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 07:27:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:27:03 INFO - Return code: 0 07:27:03 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')]} 07:27:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2 07:27:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 07:27:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:27:04 INFO - Downloaded 57940338 bytes. 07:27:04 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2 07:27:04 INFO - mkdir: /builds/slave/test-pgo/properties 07:27:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:27:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:27:04 INFO - Contents: 07:27:04 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2 07:27:04 INFO - Running post-action listener: _resource_record_post_action 07:27:04 INFO - Running post-action listener: set_extra_try_arguments 07:27:04 INFO - ##### 07:27:04 INFO - ##### Running populate-webroot step. 07:27:04 INFO - ##### 07:27:04 INFO - Running pre-action listener: _resource_record_pre_action 07:27:04 INFO - Running main action method: populate_webroot 07:27:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:04 INFO - '--tppagecycles', 07:27:04 INFO - '7'], 07:27:04 INFO - 'tests': ['tsvgm']}}, 07:27:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:27:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:27:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:27:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'tests': ['damp', 'tps']}, 07:27:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['damp', 'tps']}, 07:27:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:27:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:04 INFO - 'other': {'tests': ['a11yr', 07:27:04 INFO - 'ts_paint', 07:27:04 INFO - 'tpaint', 07:27:04 INFO - 'sessionrestore', 07:27:04 INFO - 'sessionrestore_no_auto_restore']}, 07:27:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['a11yr', 07:27:04 INFO - 'ts_paint', 07:27:04 INFO - 'tpaint', 07:27:04 INFO - 'sessionrestore', 07:27:04 INFO - 'sessionrestore_no_auto_restore']}, 07:27:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['a11yr', 07:27:04 INFO - 'ts_paint', 07:27:04 INFO - 'tpaint', 07:27:04 INFO - 'sessionrestore', 07:27:04 INFO - 'sessionrestore_no_auto_restore']}, 07:27:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['a11yr', 07:27:04 INFO - 'ts_paint', 07:27:04 INFO - 'tpaint', 07:27:04 INFO - 'sessionrestore', 07:27:04 INFO - 'sessionrestore_no_auto_restore']}, 07:27:04 INFO - 'other_l64': {'tests': ['a11yr', 07:27:04 INFO - 'ts_paint', 07:27:04 INFO - 'tpaint', 07:27:04 INFO - 'sessionrestore', 07:27:04 INFO - 'sessionrestore_no_auto_restore']}, 07:27:04 INFO - 'other_nol64': {'tests': ['a11yr', 07:27:04 INFO - 'ts_paint', 07:27:04 INFO - 'tpaint', 07:27:04 INFO - 'sessionrestore', 07:27:04 INFO - 'sessionrestore_no_auto_restore']}, 07:27:04 INFO - 'svgr': {'tests': ['tsvgx', 07:27:04 INFO - 'tsvgr_opacity', 07:27:04 INFO - 'tart', 07:27:04 INFO - 'tscrollx', 07:27:04 INFO - 'cart']}, 07:27:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['tsvgx', 07:27:04 INFO - 'tsvgr_opacity', 07:27:04 INFO - 'tart', 07:27:04 INFO - 'tscrollx', 07:27:04 INFO - 'cart']}, 07:27:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'tests': ['tp5o']}, 07:27:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'talos_options': ['--e10s'], 07:27:04 INFO - 'tests': ['tp5o']}, 07:27:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'talos_options': ['--xperf_path', 07:27:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:04 INFO - 'tests': ['tp5n']}, 07:27:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:04 INFO - 'talos_options': ['--e10s', 07:27:04 INFO - '--xperf_path', 07:27:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:04 INFO - 'tests': ['tp5n']}}, 07:27:04 INFO - 'talos.zip': {'path': '', 07:27:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:04 INFO - Running post-action listener: _resource_record_post_action 07:27:04 INFO - ##### 07:27:04 INFO - ##### Running create-virtualenv step. 07:27:04 INFO - ##### 07:27:04 INFO - Running pre-action listener: _resource_record_pre_action 07:27:04 INFO - Running main action method: create_virtualenv 07:27:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:27:04 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 07:27:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:27:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:04 INFO - Using real prefix '/usr' 07:27:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:27:04 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:06 INFO - Installing pip.................done. 07:27:06 INFO - Return code: 0 07:27:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:27:06 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')]} 07:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:06 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')]} 07:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:27:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:27:06 INFO - Using env: {'DISPLAY': ':0', 07:27:06 INFO - 'HOME': '/home/cltbld', 07:27:06 INFO - 'LANG': 'en_US.UTF-8', 07:27:06 INFO - 'LANGUAGE': 'en_US:en', 07:27:06 INFO - 'LOGNAME': 'cltbld', 07:27:06 INFO - 'MAIL': '/var/mail/cltbld', 07:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:06 INFO - 'MOZ_NO_REMOTE': '1', 07:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:06 INFO - 'NO_EM_RESTART': '1', 07:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:06 INFO - 'SHELL': '/bin/bash', 07:27:06 INFO - 'SHLVL': '1', 07:27:06 INFO - 'TERM': 'linux', 07:27:06 INFO - 'TMOUT': '86400', 07:27:06 INFO - 'USER': 'cltbld', 07:27:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:06 INFO - '_': '/tools/buildbot/bin/python'} 07:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:06 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 07:27:06 INFO - Cleaning up... 07:27:06 INFO - Return code: 0 07:27:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:27:06 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')]} 07:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:06 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')]} 07:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:27:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:27:07 INFO - Using env: {'DISPLAY': ':0', 07:27:07 INFO - 'HOME': '/home/cltbld', 07:27:07 INFO - 'LANG': 'en_US.UTF-8', 07:27:07 INFO - 'LANGUAGE': 'en_US:en', 07:27:07 INFO - 'LOGNAME': 'cltbld', 07:27:07 INFO - 'MAIL': '/var/mail/cltbld', 07:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:07 INFO - 'MOZ_NO_REMOTE': '1', 07:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:07 INFO - 'NO_EM_RESTART': '1', 07:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:07 INFO - 'SHELL': '/bin/bash', 07:27:07 INFO - 'SHLVL': '1', 07:27:07 INFO - 'TERM': 'linux', 07:27:07 INFO - 'TMOUT': '86400', 07:27:07 INFO - 'USER': 'cltbld', 07:27:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:07 INFO - '_': '/tools/buildbot/bin/python'} 07:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:07 INFO - Downloading/unpacking psutil>=0.7.1 07:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:09 INFO - Installing collected packages: psutil 07:27:09 INFO - Running setup.py install for psutil 07:27:09 INFO - building 'psutil._psutil_linux' extension 07:27:09 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 07:27:09 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 07:27:09 INFO - building 'psutil._psutil_posix' extension 07:27:09 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 07:27:09 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 07:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:09 INFO - Successfully installed psutil 07:27:09 INFO - Cleaning up... 07:27:09 INFO - Return code: 0 07:27:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:27:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:27:09 INFO - Using env: {'DISPLAY': ':0', 07:27:09 INFO - 'HOME': '/home/cltbld', 07:27:09 INFO - 'LANG': 'en_US.UTF-8', 07:27:09 INFO - 'LANGUAGE': 'en_US:en', 07:27:09 INFO - 'LOGNAME': 'cltbld', 07:27:09 INFO - 'MAIL': '/var/mail/cltbld', 07:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:09 INFO - 'MOZ_NO_REMOTE': '1', 07:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:09 INFO - 'NO_EM_RESTART': '1', 07:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:09 INFO - 'SHELL': '/bin/bash', 07:27:09 INFO - 'SHLVL': '1', 07:27:09 INFO - 'TERM': 'linux', 07:27:09 INFO - 'TMOUT': '86400', 07:27:09 INFO - 'USER': 'cltbld', 07:27:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:09 INFO - '_': '/tools/buildbot/bin/python'} 07:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:27:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:27:11 INFO - Installing collected packages: mozsystemmonitor 07:27:11 INFO - Running setup.py install for mozsystemmonitor 07:27:12 INFO - Successfully installed mozsystemmonitor 07:27:12 INFO - Cleaning up... 07:27:12 INFO - Return code: 0 07:27:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:27:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:27:12 INFO - Using env: {'DISPLAY': ':0', 07:27:12 INFO - 'HOME': '/home/cltbld', 07:27:12 INFO - 'LANG': 'en_US.UTF-8', 07:27:12 INFO - 'LANGUAGE': 'en_US:en', 07:27:12 INFO - 'LOGNAME': 'cltbld', 07:27:12 INFO - 'MAIL': '/var/mail/cltbld', 07:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:12 INFO - 'MOZ_NO_REMOTE': '1', 07:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:12 INFO - 'NO_EM_RESTART': '1', 07:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:12 INFO - 'SHELL': '/bin/bash', 07:27:12 INFO - 'SHLVL': '1', 07:27:12 INFO - 'TERM': 'linux', 07:27:12 INFO - 'TMOUT': '86400', 07:27:12 INFO - 'USER': 'cltbld', 07:27:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:12 INFO - '_': '/tools/buildbot/bin/python'} 07:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:27:12 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 07:27:12 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 07:27:12 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 07:27:12 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 07:27:12 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 07:27:12 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 07:27:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:27:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 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 07:27:14 INFO - Downloading docopt-0.6.1.tar.gz 07:27:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:14 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:14 INFO - Running setup.py install for blobuploader 07:27:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:27:15 INFO - Running setup.py install for requests 07:27:15 INFO - Running setup.py install for docopt 07:27:15 INFO - Successfully installed blobuploader requests docopt 07:27:15 INFO - Cleaning up... 07:27:15 INFO - Return code: 0 07:27:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:27:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:15 INFO - Using env: {'DISPLAY': ':0', 07:27:15 INFO - 'HOME': '/home/cltbld', 07:27:15 INFO - 'LANG': 'en_US.UTF-8', 07:27:15 INFO - 'LANGUAGE': 'en_US:en', 07:27:15 INFO - 'LOGNAME': 'cltbld', 07:27:15 INFO - 'MAIL': '/var/mail/cltbld', 07:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:15 INFO - 'MOZ_NO_REMOTE': '1', 07:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:15 INFO - 'NO_EM_RESTART': '1', 07:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:15 INFO - 'SHELL': '/bin/bash', 07:27:15 INFO - 'SHLVL': '1', 07:27:15 INFO - 'TERM': 'linux', 07:27:15 INFO - 'TMOUT': '86400', 07:27:15 INFO - 'USER': 'cltbld', 07:27:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:15 INFO - '_': '/tools/buildbot/bin/python'} 07:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:27:15 INFO - Running setup.py (path:/tmp/pip-H0Cly7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:27:15 INFO - Running setup.py (path:/tmp/pip-hUoqkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:27:15 INFO - Running setup.py (path:/tmp/pip-VFCclD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:27:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:27:15 INFO - Running setup.py (path:/tmp/pip-5smVcS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:27:16 INFO - Running setup.py (path:/tmp/pip-CXKA0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:27:16 INFO - Running setup.py (path:/tmp/pip-R8vbbL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:27:16 INFO - Running setup.py (path:/tmp/pip-R4bRiu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:27:16 INFO - Running setup.py (path:/tmp/pip-5c2Sc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:27:16 INFO - Running setup.py (path:/tmp/pip-EBoeV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:27:16 INFO - Running setup.py (path:/tmp/pip-LSeQmW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:27:16 INFO - Running setup.py (path:/tmp/pip-qjttSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:27:16 INFO - Running setup.py (path:/tmp/pip-l1mLuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:27:16 INFO - Running setup.py (path:/tmp/pip-KnYItp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:27:16 INFO - Running setup.py (path:/tmp/pip-nkZkzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:27:16 INFO - Running setup.py (path:/tmp/pip-V1x6s_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:27:16 INFO - Running setup.py (path:/tmp/pip-M5Jt2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:27:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:27:16 INFO - Running setup.py (path:/tmp/pip-fK8k3b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:27:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:27:16 INFO - Running setup.py install for manifestparser 07:27:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Running setup.py install for mozcrash 07:27:17 INFO - Running setup.py install for mozdebug 07:27:17 INFO - Running setup.py install for mozdevice 07:27:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Running setup.py install for mozfile 07:27:17 INFO - Running setup.py install for mozhttpd 07:27:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Running setup.py install for mozinfo 07:27:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Running setup.py install for mozInstall 07:27:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:27:17 INFO - Running setup.py install for mozleak 07:27:17 INFO - Running setup.py install for mozlog 07:27:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:27:18 INFO - Running setup.py install for moznetwork 07:27:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:27:18 INFO - Running setup.py install for mozprocess 07:27:18 INFO - Running setup.py install for mozprofile 07:27:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:27:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:27:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:27:18 INFO - Running setup.py install for mozrunner 07:27:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:27:18 INFO - Running setup.py install for mozscreenshot 07:27:18 INFO - Running setup.py install for moztest 07:27:18 INFO - Running setup.py install for mozversion 07:27:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:27:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:27:18 INFO - Cleaning up... 07:27:18 INFO - Return code: 0 07:27:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:27: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')]} 07:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:27:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:18 INFO - Using env: {'DISPLAY': ':0', 07:27:18 INFO - 'HOME': '/home/cltbld', 07:27:18 INFO - 'LANG': 'en_US.UTF-8', 07:27:18 INFO - 'LANGUAGE': 'en_US:en', 07:27:18 INFO - 'LOGNAME': 'cltbld', 07:27:18 INFO - 'MAIL': '/var/mail/cltbld', 07:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:18 INFO - 'MOZ_NO_REMOTE': '1', 07:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:18 INFO - 'NO_EM_RESTART': '1', 07:27:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:18 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:18 INFO - 'SHELL': '/bin/bash', 07:27:18 INFO - 'SHLVL': '1', 07:27:18 INFO - 'TERM': 'linux', 07:27:18 INFO - 'TMOUT': '86400', 07:27:18 INFO - 'USER': 'cltbld', 07:27:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:18 INFO - '_': '/tools/buildbot/bin/python'} 07:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:27:18 INFO - Running setup.py (path:/tmp/pip-6CYKdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:27:19 INFO - Running setup.py (path:/tmp/pip-ny23Ew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:27:19 INFO - Running setup.py (path:/tmp/pip-El0Qxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:27:19 INFO - Running setup.py (path:/tmp/pip-ZSnXn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:27:19 INFO - Running setup.py (path:/tmp/pip-uDcDPR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:27:19 INFO - Running setup.py (path:/tmp/pip-1XGfuJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:27:19 INFO - Running setup.py (path:/tmp/pip-JKjJLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:27:19 INFO - Running setup.py (path:/tmp/pip-H3jSB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:27:19 INFO - Running setup.py (path:/tmp/pip-BL0xOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:27:19 INFO - Running setup.py (path:/tmp/pip-kzoYZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:27:19 INFO - Running setup.py (path:/tmp/pip-6rGESr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:27:19 INFO - Running setup.py (path:/tmp/pip-JhtYwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:27:19 INFO - Running setup.py (path:/tmp/pip-8WC3rR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:27:19 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)) 07:27:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:27:19 INFO - Running setup.py (path:/tmp/pip-cR6t5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:27:20 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)) 07:27:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:27:20 INFO - Running setup.py (path:/tmp/pip-8SA_dK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:27:20 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)) 07:27:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:27:20 INFO - Running setup.py (path:/tmp/pip-gPSWpb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:27:20 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)) 07:27:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:27:20 INFO - Running setup.py (path:/tmp/pip-MPLP80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:27:20 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)) 07:27:20 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)) 07:27:20 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)) 07:27:20 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)) 07:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:20 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 07:27:20 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 07:27:20 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 07:27:20 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 07:27:20 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 07:27:20 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 07:27:22 INFO - Downloading blessings-1.6.tar.gz 07:27:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:27:22 INFO - Installing collected packages: blessings 07:27:22 INFO - Running setup.py install for blessings 07:27:22 INFO - Successfully installed blessings 07:27:22 INFO - Cleaning up... 07:27:22 INFO - Return code: 0 07:27:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:27:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:27:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:27:22 INFO - Reading from file tmpfile_stdout 07:27:22 INFO - Current package versions: 07:27:22 INFO - argparse == 1.2.1 07:27:22 INFO - blessings == 1.6 07:27:22 INFO - blobuploader == 1.2.4 07:27:22 INFO - docopt == 0.6.1 07:27:22 INFO - manifestparser == 1.1 07:27:22 INFO - mozInstall == 1.12 07:27:22 INFO - mozcrash == 0.16 07:27:22 INFO - mozdebug == 0.1 07:27:22 INFO - mozdevice == 0.47 07:27:22 INFO - mozfile == 1.2 07:27:22 INFO - mozhttpd == 0.7 07:27:22 INFO - mozinfo == 0.9 07:27:22 INFO - mozleak == 0.1 07:27:22 INFO - mozlog == 3.1 07:27:22 INFO - moznetwork == 0.27 07:27:22 INFO - mozprocess == 0.22 07:27:22 INFO - mozprofile == 0.27 07:27:22 INFO - mozrunner == 6.11 07:27:22 INFO - mozscreenshot == 0.1 07:27:22 INFO - mozsystemmonitor == 0.0 07:27:22 INFO - moztest == 0.7 07:27:22 INFO - mozversion == 1.4 07:27:22 INFO - psutil == 3.1.1 07:27:22 INFO - requests == 1.2.3 07:27:22 INFO - wsgiref == 0.1.2 07:27:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:27:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:22 INFO - Using env: {'DISPLAY': ':0', 07:27:22 INFO - 'HOME': '/home/cltbld', 07:27:22 INFO - 'LANG': 'en_US.UTF-8', 07:27:22 INFO - 'LANGUAGE': 'en_US:en', 07:27:22 INFO - 'LOGNAME': 'cltbld', 07:27:22 INFO - 'MAIL': '/var/mail/cltbld', 07:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:22 INFO - 'MOZ_NO_REMOTE': '1', 07:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:22 INFO - 'NO_EM_RESTART': '1', 07:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:22 INFO - 'SHELL': '/bin/bash', 07:27:22 INFO - 'SHLVL': '1', 07:27:22 INFO - 'TERM': 'linux', 07:27:22 INFO - 'TMOUT': '86400', 07:27:22 INFO - 'USER': 'cltbld', 07:27:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:22 INFO - '_': '/tools/buildbot/bin/python'} 07:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 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)) 07:27:22 INFO - Cleaning up... 07:27:22 INFO - Return code: 0 07:27:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:27:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:27:22 INFO - Using env: {'DISPLAY': ':0', 07:27:22 INFO - 'HOME': '/home/cltbld', 07:27:22 INFO - 'LANG': 'en_US.UTF-8', 07:27:22 INFO - 'LANGUAGE': 'en_US:en', 07:27:22 INFO - 'LOGNAME': 'cltbld', 07:27:22 INFO - 'MAIL': '/var/mail/cltbld', 07:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:22 INFO - 'MOZ_NO_REMOTE': '1', 07:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:22 INFO - 'NO_EM_RESTART': '1', 07:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:22 INFO - 'SHELL': '/bin/bash', 07:27:22 INFO - 'SHLVL': '1', 07:27:22 INFO - 'TERM': 'linux', 07:27:22 INFO - 'TMOUT': '86400', 07:27:22 INFO - 'USER': 'cltbld', 07:27:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:22 INFO - '_': '/tools/buildbot/bin/python'} 07:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:22 INFO - Downloading/unpacking jsonschema 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:24 INFO - Downloading/unpacking functools32 (from jsonschema) 07:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:24 INFO - Downloading functools32-3.2.3-2.tar.gz 07:27:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:27:24 INFO - warning: no files found matching '*.txt' 07:27:24 INFO - no previously-included directories found matching 'build' 07:27:24 INFO - no previously-included directories found matching 'dist' 07:27:24 INFO - no previously-included directories found matching '.git*' 07:27:24 INFO - Installing collected packages: jsonschema, functools32 07:27:25 INFO - Running setup.py install for functools32 07:27:25 INFO - warning: no files found matching '*.txt' 07:27:25 INFO - no previously-included directories found matching 'build' 07:27:25 INFO - no previously-included directories found matching 'dist' 07:27:25 INFO - no previously-included directories found matching '.git*' 07:27:25 INFO - Successfully installed jsonschema functools32 07:27:25 INFO - Cleaning up... 07:27:25 INFO - Return code: 0 07:27:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:27:25 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')]} 07:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:25 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')]} 07:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4c0a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f20e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', '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 07:27:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:27:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:27:25 INFO - Using env: {'DISPLAY': ':0', 07:27:25 INFO - 'HOME': '/home/cltbld', 07:27:25 INFO - 'LANG': 'en_US.UTF-8', 07:27:25 INFO - 'LANGUAGE': 'en_US:en', 07:27:25 INFO - 'LOGNAME': 'cltbld', 07:27:25 INFO - 'MAIL': '/var/mail/cltbld', 07:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:25 INFO - 'MOZ_NO_REMOTE': '1', 07:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:25 INFO - 'NO_EM_RESTART': '1', 07:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:25 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:25 INFO - 'SHELL': '/bin/bash', 07:27:25 INFO - 'SHLVL': '1', 07:27:25 INFO - 'TERM': 'linux', 07:27:25 INFO - 'TMOUT': '86400', 07:27:25 INFO - 'USER': 'cltbld', 07:27:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:25 INFO - '_': '/tools/buildbot/bin/python'} 07:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:25 INFO - Downloading/unpacking flake8 07:27:25 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 07:27:25 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 07:27:25 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 07:27:25 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 07:27:25 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 07:27:25 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 07:27:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:27:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:27:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 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 07:27:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:27:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:27 INFO - no previously-included directories found matching 'docs/_build' 07:27:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:27:27 INFO - Running setup.py install for pep8 07:27:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:27 INFO - no previously-included directories found matching 'docs/_build' 07:27:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:27:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:27:28 INFO - Cleaning up... 07:27:28 INFO - Return code: 0 07:27:28 INFO - Running post-action listener: _resource_record_post_action 07:27:28 INFO - Running post-action listener: _start_resource_monitoring 07:27:28 INFO - Starting resource monitoring. 07:27:28 INFO - ##### 07:27:28 INFO - ##### Running install step. 07:27:28 INFO - ##### 07:27:28 INFO - Running pre-action listener: _resource_record_pre_action 07:27:28 INFO - Running main action method: install 07:27:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:27:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:27:28 INFO - Reading from file tmpfile_stdout 07:27:28 INFO - Detecting whether we're running mozinstall >=1.0... 07:27:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:27:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:27:28 INFO - Reading from file tmpfile_stdout 07:27:28 INFO - Output received: 07:27:28 INFO - Usage: mozinstall [options] installer 07:27:28 INFO - Options: 07:27:28 INFO - -h, --help show this help message and exit 07:27:28 INFO - -d DEST, --destination=DEST 07:27:28 INFO - Directory to install application into. [default: 07:27:28 INFO - "/builds/slave/test-pgo"] 07:27:28 INFO - --app=APP Application being installed. [default: firefox] 07:27:28 INFO - mkdir: /builds/slave/test-pgo/build/application 07:27:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:27:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:27:42 INFO - Reading from file tmpfile_stdout 07:27:42 INFO - Output received: 07:27:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:27:42 INFO - Running post-action listener: _resource_record_post_action 07:27:42 INFO - ##### 07:27:42 INFO - ##### Running run-tests step. 07:27:42 INFO - ##### 07:27:42 INFO - Running pre-action listener: _resource_record_pre_action 07:27:42 INFO - Running main action method: run_tests 07:27:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:27:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:27:42 INFO - Python 2.7.3 07:27:42 INFO - Return code: 0 07:27:42 INFO - grabbing minidump binary from tooltool 07:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:42 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 0x1780e30>, '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 0x1781d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17821c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:27:42 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 07:27:42 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 07:27:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:27:42 INFO - Return code: 0 07:27:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:27:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:27:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:27:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:27:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:27:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:27:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:27:44 INFO - Return code: 0 07:27:44 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/1454590948/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:27:44 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/1454590948/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 07:27:44 INFO - Using env: {'DISPLAY': ':0', 07:27:44 INFO - 'HOME': '/home/cltbld', 07:27:44 INFO - 'LANG': 'en_US.UTF-8', 07:27:44 INFO - 'LANGUAGE': 'en_US:en', 07:27:44 INFO - 'LOGNAME': 'cltbld', 07:27:44 INFO - 'MAIL': '/var/mail/cltbld', 07:27:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:27:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:44 INFO - 'MOZ_NO_REMOTE': '1', 07:27:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:44 INFO - 'NO_EM_RESTART': '1', 07:27:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:27:44 INFO - 'SHELL': '/bin/bash', 07:27:44 INFO - 'SHLVL': '1', 07:27:44 INFO - 'TERM': 'linux', 07:27:44 INFO - 'TMOUT': '86400', 07:27:44 INFO - 'USER': 'cltbld', 07:27:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180', 07:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:44 INFO - '_': '/tools/buildbot/bin/python'} 07:27:44 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/1454590948/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 07:27:44 INFO - mozversion INFO | application_buildid: 20160204050228 07:27:44 INFO - mozversion INFO | application_changeset: 060086e4af2ea06b0d6047004d2fc6ff543a1452 07:27:44 INFO - mozversion INFO | application_display_name: Nightly 07:27:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:27:44 INFO - mozversion INFO | application_name: Firefox 07:27:44 INFO - mozversion INFO | application_remotingname: firefox 07:27:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:27:44 INFO - mozversion INFO | application_vendor: Mozilla 07:27:44 INFO - mozversion INFO | application_version: 45.0 07:27:44 INFO - mozversion INFO | platform_buildid: 20160204050228 07:27:44 INFO - mozversion INFO | platform_changeset: 060086e4af2ea06b0d6047004d2fc6ff543a1452 07:27:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:27:44 INFO - mozversion INFO | platform_version: 45.0 07:27:44 INFO - 2016-02-04 07:27:44,246 DEBUG : using testdate: 1454599664 07:27:44 INFO - 2016-02-04 07:27:44,246 DEBUG : actual date: 1454599664 07:27:44 INFO - 2016-02-04 07:27:44,255 INFO : starting webserver on 'localhost:58415' 07:27:44 INFO - 2016-02-04 07:27:44,256 INFO : Starting test suite talos-linux64-ix-015 07:27:44 INFO - 2016-02-04 07:27:44,256 INFO : Starting test dromaeo_css 07:27:44 INFO - 2016-02-04 07:27:44,256 DEBUG : operating with platform_type : linux_ 07:27:44 INFO - 2016-02-04 07:27:44,257 INFO : Initialising browser for dromaeo_css test... 07:27:44 INFO - 2016-02-04 07:27:44,273 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbsfjTs/profile http://localhost:58415/getInfo.html 07:27:48 INFO - 2016-02-04 07:27:48,245 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:27:48 INFO - 2016-02-04 07:27:48,246 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:27:48 INFO - 2016-02-04 07:27:48,246 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:27:48 INFO - 2016-02-04 07:27:48,246 DEBUG : BROWSER_OUTPUT: __metrics 07:27:48 INFO - 2016-02-04 07:27:48,407 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] 07:27:49 INFO - 2016-02-04 07:27:49,093 INFO : Browser initialized. 07:27:49 INFO - 2016-02-04 07:27:49,094 INFO : Running cycle 1/1 for dromaeo_css test... 07:27:49 INFO - 2016-02-04 07:27:49,094 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbsfjTs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:28:00 INFO - 2016-02-04 07:28:00,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 134201344 07:28:00 INFO - 2016-02-04 07:28:00,883 DEBUG : BROWSER_OUTPUT: 07:28:51 INFO - 2016-02-04 07:28:51,859 DEBUG : BROWSER_OUTPUT: 1454599731858 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] 07:31:00 INFO - 2016-02-04 07:31:00,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58415/tests/dromaeo/cssquery-ext.html) 07:31:01 INFO - 2016-02-04 07:31:01,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 247275520 07:31:01 INFO - 2016-02-04 07:31:01,274 DEBUG : BROWSER_OUTPUT: 07:34:03 INFO - 2016-02-04 07:34:03,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/dromaeo/cssquery-ext.html (next: http://localhost:58415/tests/dromaeo/cssquery-jquery.html) 07:34:03 INFO - 2016-02-04 07:34:03,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 211054592 07:34:03 INFO - 2016-02-04 07:34:03,977 DEBUG : BROWSER_OUTPUT: 07:37:05 INFO - 2016-02-04 07:37:05,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58415/tests/dromaeo/cssquery-mootools.html) 07:37:06 INFO - 2016-02-04 07:37:06,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 213094400 07:37:06 INFO - 2016-02-04 07:37:06,224 DEBUG : BROWSER_OUTPUT: 07:40:07 INFO - 2016-02-04 07:40:07,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58415/tests/dromaeo/cssquery-prototype.html) 07:40:08 INFO - 2016-02-04 07:40:08,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 199241728 07:40:08 INFO - 2016-02-04 07:40:08,469 DEBUG : BROWSER_OUTPUT: 07:43:10 INFO - 2016-02-04 07:43:10,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58415/tests/dromaeo/cssquery-yui.html) 07:43:11 INFO - 2016-02-04 07:43:11,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 198823936 07:43:11 INFO - 2016-02-04 07:43:11,412 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/dromaeo/cssquery-yui.html (next: http://localhost:58415/tests/dromaeo/cssquery-dojo.html) 07:46:13 INFO - 2016-02-04 07:46:13,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 255754240 07:46:13 INFO - 2016-02-04 07:46:13,897 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,897 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:46:13 INFO - 2016-02-04 07:46:13,897 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:46:13 INFO - 2016-02-04 07:46:13,897 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:46:13 INFO - 2016-02-04 07:46:13,897 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:46:13 INFO - 2016-02-04 07:46:13,897 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3340.515625234341;3411.351843149803;3436.810975396352;3439.604445488768;3464.324456730937;5645.802396916109;5680.914786278209;5698.772049118031;5705.400932902048;5707.600467967244;5698.943010569893;5753.741081651326;5780.0751879699155;5781.913271300934;5797.739101740422;4972.875678108058;5035.62232832539;5230.633855630107;5254.474552544753;5328.46715328468;5194.662346947455;5203.86990325243;5209.036328279261;5214.608904332172;5215.295935048777;5101.081805275049;5120.257562653413;5207.218917162418;5228.764705588239;5241.135212689902;5125.077486052509;5131.743412829381;5132.8460146195675;5138.922916156261;5140.023395554851;5061.468545802712;5100.056489549445;5167.354080739908;5186.636935414523;5205.479452054764;5186.040582492251;5307.177387504943;5314.362276526803;5451;5460.26286451328;6061.181740465025;6174.104754810527;6177.042558403455;6178.351273116303;6181.3818618138275;5753.712314384264;6222.657753823538;6229.813105606794;6233.438990490832;6238.9376106238815;5597.804076857331;5648.887022259573;5665.178549110356;5671.461211184931;5700.942990570083;6089.360617135137;6122.816315510542;6136.294326152461;6138.785142519991;6163.38366163389;5795.710214489343;5927.673977931255;5960.552958528127;5971.611845230133;5977.073553599199;6068.302145253352;6158.04550294705;6164.229471316085;6166.167567378347;6167.938320616737;6095.512359011357;6096.512279017668;6097.969510152421;6112.327643959161;6127.019676851772;5856.736446859902;5944.167816505693;6007.068904319837;6137.723802428902;6143.907841382383;4607.539246075433;4607.9308810367875;4607.953920460753;4608.446986361591;4610.446746390455;4091.7340372876265;4144.896377590524;4149.190907772955;4157.064660451435;4159.272127377697;5789.363170051291;5795.855103622359;5801.042827933428;5811.535077193815;5822.214001109881;5912.674802885796;6125.693715314216;6160.260768707783;6173.166622505904;6198.163247961467;5606.775728970877;5610.158476228598;5710.71446427677;5729.28383952006;5770.451807078321;5114.71869047206;5133.486651334912;5163;5169.53474187325;5172.689638621695;5999.310079340931;6173.444390005011;6337.8732425352155;6341.778037768656;6346.587471814318;6092.238470191226;6138.02057325484;6179.443850053517;6189.288231853395;6207.224096987877;6311.431971122621;6357.96821015892;6364.968175159094;6372.299047104722;6379.553431259953;5661.377248502579;5772.56705747079;6020;6113.633182008915;6119.051547010221;6153.72308246139;6191.102290167991;6205.131281620486;6206.813795586139;6206.937930620636;6010.609310394811;6031.089730847243;6037.909431358621;6040.637561746309;6061.454469097803;5716.514096301861;5864.179014937998;5882.794102206402;5958.225430693982;6000.669963152069;5847.590668653153;5873.706314684334;5880.088586269135;5880.294364676266;5880.500157486662;5952.58331916779;6006.669633170043;6009.038553831366;6011.158437818796;6016;5669.177969194361;5760.049591817303;5779.364269930388;5868.471837534642;5873.4126587340925 07:46:13 INFO - 2016-02-04 07:46:13,897 DEBUG : BROWSER_OUTPUT: |1;ext.html;579.3569138256535;624.9906251406228;632.4371309534514;645.303072681504;649.6978904809263;33699.326013479746;41631.583684163146;41981.79009104958;42098;42289.78855105724;45369.31946020812;46040.539594604044;46097.539024609745;46131.538684613144;46152.07695846081;8127.146649601796;8258.917410825905;8964.462132272085;9143.908560914406;10293;10459.686209413692;10481.633142840003;10551.261411701145;10568.471576421187;10573.312734672221;10607;10702.090322322612;10705.571777128944;10707.036366726992;10710.143188544936;10556.419396933166;10634.840477392845;10648.201384896087;10655.78688426231;10656.254062215608;10388.584456621726;10539.262251642389;10541.947290263499;10543.52554135058;10545.578176872992;41489;41965;41966;41977.58022419767;42016.78991605053;3689.8339574719203;4112.691548133902;4119.196756632457;4139.689523285735;4274.038341373197;31621.20946976344;32045.679543204737;32384.676153238637;32559.837200813843;32815.179620509676;4173.3114036184;4304.182205380967;4306;4326.832508749854;4346.521882592912;297350;298193;298356;299274;301173;59899.10151347733;60866.69566652139;60996.390036099074;68597.65701171462;69582.65208674026;62260;62487.43781405501;62819.6859015702;62892.056619150746;62927;17420.128993550527;17530.123493825256;17621;17627.118644067745;17651.82348176502;13632.65918352049;13778.311084445737;13790.448382064606;13792.103513271806;13969.23169225682;19956.90021549883;20206.696899546518;20273.695894561297;20281.391558253275;20285;7546.2831031051965;7708.38332933364;7778.183290754502;7781.727639532589;7807.687692492236;985.103555764251;994.721477986165;1013.7313611892854;1110.8611423572054;1129.5312445335094;27099.1870243893;27531.86049298855;27710.307242319104;27787.19383240083;28095.57856632152;924.611663101499;1077.617445806743;1130.6494986554194;1130.9547618095185;1145.7765735681628;12790.61628151157;13364.465421383231;13465.461381544825;14899.702005960036;15272.38910443592;344387;348602;349336;354162;354465;52388.73805630948;52533;52655.47344526506;52657.736711316196;52670.73664631729;1482.629342664334;1483.2731961338866;1488.4418343121329;1491.1649476293528;1498.7452133137392;26124.477510450066;28432.57351139693;28614.67378315967;29113.272168195963;29287.12138635844;48507.5149248503;48966.51033489619;48982;49000.50999489959;49018.754906225244;259453;259540;260700;260987;261784;33309.16727081745;33365.332693346485;33464.33071338511;33694.326113478084;33949;43399.78300108479;43743;44196.337054944845;44228;44412.77793611011;34980.65019349876;35721.82139089288;35921;36674.44988325231;37123.62876371202;37313;37987;39422.80288598539;40249.59750402458;41940.58059419367;33094.83452582722;33535;33821.66178338185;34876.825615872775;37932.2413551733;30523.63153666098;30632.148591591103;30851;33933.830330848185;33972.49041264334;24677.753222468265;24902.875485622455;25223.11719089823;25279.36801579975;25788.226353209433 07:46:13 INFO - 2016-02-04 07:46:13,899 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.30238965083544;390.3987858697605;392.21361170852435;392.2821237136041;394.15060544526557;15138.167400792952;16135.354585816583;17142.485725428225;18689.62620747586;18700.812991870076;17753.28986840525;18056.4583062508;18139.727904081417;18548.81451185488;18755.3435629753;6200.379962003797;6329.113924050614;6334.873302533946;6340.682965851712;6364.649944253064;4588.564086411802;4733.384659994196;4736.029114031615;6243.906341404882;6719.22728886177;6707.228668703113;6798.04827324175;6807.965960170192;6869.278725733776;6877.965610171942;6737.865242695143;6748.865022699568;6777.661116944133;6781.084553585277;6786.7963961080995;6425.646589437579;6473.9676301618665;6490.480761539113;6604.471642268607;6608.60348379094;22816.543669126524;23027.30918072444;23040.193593224325;23323;23468.413289667726;2493.763092506227;2561.1164148368784;2698.7571118599226;2714.782817374605;2724.441489494649;14444.92777536116;14689.559313220621;14737.778933316009;14759.557213283511;15004.924975375163;1849.3897013985352;1890.6218756248804;1968.7145363922293;2025.2709024751077;2134.4130364149983;73253.633731831;76872.61563692146;78657;79577.20422795755;80026.59986700029;15176.772348414783;16000.839991600167;16017.679646407007;16023.118728469814;16026.919865400598;24870.875645622018;24893;25284.620730689054;25286.74713252844;25322.493550129264;9695.854562181574;9788.55951482185;9909.554070066864;10022.849657255147;10050.346727462691;8590.055093939662;8608.268297194683;8621;8691.130886911385;8712.346574006975;7068.540544864567;7847.176046515034;7985.2014798519685;8019.639116239783;8042.557659328676;1887.452638734779;1901.306023301485;1922.1926790747918;1936.5545924437458;2324.83726139172;913.1918252346588;949.4825320200507;971.6842026341467;1009.3641006166068;1028;13777.793333100011;13877.306134693225;16191.866569340269;16699.66600668004;17061.57346066358;923.2613908872875;986.3145114145743;986.9753256168653;993.478423827482;1051.2115913065202;9627.133557979676;9796.363236389612;9804.36271642341;9904.801903961881;9994;621967;622025.7716511891;638542;658122;658647;81897;83808;85410;85466.57266713626;85554.99999999875;1171.8652354979115;1173.7124404520946;1188.2333004376148;1189.120051162134;1202.008343116932;15753.606159846095;15779.211039447751;15804.446844360393;16049.277782500048;16191.838081619033;35832.820835895654;36105.458418124275;36482.27035459223;36918.815405922796;37545.4368184472;47335;50075;50236.748816255684;50329.49670503248;52752;9507.334486585873;9543;9636.42181469114;10046.146077583488;10067.597296108073;11897;11971.940140299243;13747.656308592364;15215.923920380328;15373.000754950892;14553.92723036378;14601.415943362146;14959.17724525118;15255.923720381326;15445.0732956023;13949.302534873419;14511.167046226326;14802;15155.92422037927;15244.771328430304;14678.486252981094;14889.553313400615;15138.243087845784;15232;15611.453599123975;9708.2718796092;9753.853692194481;10012;10019.54912028946;10077.949610251902;15165.393384264506;15330;15426.84573154254;15440.30518626642;15688.843111569195 07:46:13 INFO - 2016-02-04 07:46:13,900 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1516.416179770788;1746.9563260918478;1752.5443384719977;1783.5630270583708;1799.3612267644983;7211.855762884746;7559.5464272143645;7571.6214189290595;7575.280348366903;7577.545347279167;6730.192376914765;6830.385265326119;7336.4130869530445;7523.322900938914;7555.055618047744;2298.5517824024364;2304.4699719064624;2331.067572970808;2333.276684227886;2335.065973610561;2084.062172022596;2323.2101085630884;2359.893804778789;2360.7875291223786;2361.327021798788;1933.4489670443927;2305.296884450242;2341.7072865891764;2341.8594884306913;2343.156463673085;2255.391044418006;2299.0803678528555;2300.7009088818513;2316.884155792212;2331.988340058297;2324.651302304651;2328.6856274403076;2352.988235058831;2353.929382118522;2392.174699728591;7579.54522728638;7696.923030769733;7697.692092316301;7698.576578288192;7699.576523291216;4657.417822772153;4798.760061996886;4799.13615549201;4801.135795556798;4801.783919723621;3158.1315138336913;3180.904572862818;3186.5060915558124;3210.085125739153;3254.8372581370836;1084.159776173464;1100.6312885183472;1140.236041851961;1930.3629802165392;1965.3907288740536;10160.796784064278;10179.89820101797;10267.691969240936;10343.120834728981;10395.32430392022;4177.101923086551;4181;4265.210935976854;4277.850275240352;4285.7000009999;8542.316614670812;8586.828263434822;8604.612792424356;8614.224719775126;8615.913840861636;4817.012512434942;4824.276358546246;4826.251930950708;4828.493008234155;4831.130396528659;4483.30508771141;4488.865334039984;4491.752953587518;4493.483249426293;4493.932591011137;3478.4434490481403;3512;3530.382183117944;3537.398642230827;3565.2691198304287;1063.622414043019;1064.41989115932;1078.4931082391263;1089.2810744908481;1101.6199411203122;1149.149629274331;1153.1524329617723;1156.9826452603218;1166.953321867133;1190.422645017166;7085.078939737904;7094.645267736696;7240.746573869889;7300.96349518249;7313.2321106284135;1064.7125276175389;1113.3709454158375;1167.2237961755338;1174.0783484964263;1178.935158566287;5904.586678932434;5914.526837852962;5956.2852457704485;5963.105534169909;5964.314103878023;8671.783205419788;8793.780155496035;8913.732588022369;8936.24041956428;8944.195022448012;9148.2681385489;9154.084591540792;9156.267498600097;9274.536273186313;9286.442813431217;6954.3045695430055;7008.614526201108;7058.505904586732;7131.108611423572;7139.785806425815;7297.124345078624;7370.373518251009;7372.189059203591;7377.557346559223;7381.335679788845;8148.511089334659;8168.224018718212;8359.331253499584;8368.24685778283;8393.790155246168;8318.41771076043;8343.332533397435;8473.364497662576;8505.787355316166;8512;6447.194100737408;6625.635590042401;6637.734490620321;6643.236027856665;6659.4006539411685;7128.8217794553475;7146.249643787535;7198.49610527258;7200.531965422231;7202.819929501804;6074.635521868702;6589.967050164719;6773.458123350021;6829.52193346461;6928.1339832520935;6892.241853396223;6901.654917254017;6946.756863509753;6976.7558135465015;7022.157341119098;6959.060526828814;7071.964640176766;7096.503244772816;7102.964485177541;7107.324804143598;6546.345365463416;6569.967150164219;6577.046328282468;6581.111549940697;6582.572132811352;6449.451796597342;6480.287168411565;6594.373534514213;6598.04328372393;6616.338366163345 07:46:13 INFO - 2016-02-04 07:46:13,900 DEBUG : BROWSER_OUTPUT: |4;prototype.html;341.8837595217626;343.8401143468287;346.7780620402941;348.0723870884094;354.07586200017965;6089.238845144357;6130.570860039794;6237.376262373766;6251.4686251668545;6276.372362763721;5828.242328497289;5913.586048976563;5954.583179177459;6113.663748493831;6136.723847426865;4738.47876733559;4738.573528382445;4759.119562880861;4767.04659068186;4780.880477988043;4531.43357080365;4754.358161648185;4757.0723708876785;4761.880952976168;4772.856814295559;4600.953990460102;4618.56123668251;4733.479317275097;4738.265568836819;4743;4714.834980775657;4721.905561888743;4724.031573527419;4726.95273047272;4727.196376615983;4157.08544120293;4159.064210552601;4162.708610397273;4164.146349998243;4167.458230430055;5734.598578099493;5837.50381217597;5841.153032810261;5842.4741773240185;5848.035074212749;5380.946190538084;5386.91919621202;5388.461153884619;5397.136458166714;5399.70301633414;6549.705263263165;6551.868962620769;6557.868842623168;6560.147180866505;6563.245226798931;4438.467383913919;4443.33349997503;4443.7111587746695;4445.911081778347;4446.3552784846015;6633.369829866203;6697.19633643961;6743.325667433218;6753.0545723599225;6755.459563234929;4594.33382159585;4594.724316541018;4596.885077873013;4598.701084429501;4599.241125214369;4660.906781864343;4668.066386722669;4675.462321832964;4675.696079754805;4676.906461870743;5413.918791218135;5422.457754224546;5434.64674796137;5436.728163591804;5441.156620723794;6420.1974753155855;6568.408843204134;6568.8357791055605;6571.31001244872;6572.86854262912;1619.1742211472233;1644.9506514804575;1646.218046427961;1646.5554300338842;1646.6048148444288;1054.9419781911915;1078.358376765823;1084.6745976207264;1090.9727256818644;1110.1784679337393;6353.936460635427;6363.0455431684695;6372.553921225563;6379.71291291893;6385.712642931079;6588.077669126326;6792.320767923168;6797.728090876409;6811.046453496514;6813.931860681429;6315.684215789284;6328.936710632926;6355.0785136155;6443.4523065539015;6451.741930322734;3656.5612126544984;3697.7411581189594;3703.2408356286896;3707.1102935295335;3709.221063576625;6886.311368863074;7035.894461583081;7039.084918960502;7040.2607726189035;7041.366277035091;7062.717491300393;7067.82330441743;7073.398761105261;7075.964620176969;7077.3984211341585;7062.223155452896;7070.116235470567;7071.398931090812;7071.611061391673;7075.504714670026;6683.665816709048;6889.2421833599265;6892.793216203522;6895.4138898194215;6896.965515172392;6768.627725475146;6790.25307216196;6793.558418702769;6801.693923773343;6805.727770889109;7048.083749112582;7058.964705176647;7069.116360454943;7071.25751796054;7073.964630176816;4516.961098947195;4581.060882519009;4614.238650622609;4619.93070103942;4665.486796452456;6736.831579210363;6811.2167100784045;6813.1142951415995;6813.3527314905;6814.693338799865;6612.305707900794;6618.172728408949;6620.602763834186;6621.735130594722;6628.668566571749;6453.806385808433;6585.20977482686;6594.8351291218105;6600.141981542369;6601.174853143357;6470.967645161744;6484.546081774419;6492.0261960706275;6499.902501462388;6502.349765023459;6596.80209593713;6606.900896486461;6608.900866486911;6614.239362473377;6615.702293396905;6294.464970477561;6362.331955144643;6460.838479038061;6461.741530338922;6473.449756770728 07:46:13 INFO - 2016-02-04 07:46:13,901 DEBUG : BROWSER_OUTPUT: |5;yui.html;819.1685439279131;893.7810236492058;894.977625559361;916.2212119698257;921.5438358012776;13819.792703109462;14157.22135282559;14162.362693678797;14173.71652566948;14204.07673501223;12902.935485322583;15466.767998480032;15510;15541.067535947852;15939.84060159398;761.603965937712;767.6929228308666;915.2769312243337;917.9908200918005;931.2224292715557;923.8383282925495;924.075924075924;932.8693982842374;932.911373419524;933.4772527384653;947.393668052447;952.6141912525438;955.9091886270793;956.4834989105909;957.9089986451276;931.529577563333;931.7251410833752;936.7845395559026;939.5396255834626;939.8684184214216;696.098552374676;697.2817997462622;697.5709938387855;698.5773606967762;698.7240040184149;14750.409983600643;14796.70406591873;14800.629984250372;14823.258837058213;14958.252087395587;13419.396127174301;13449.798253026212;13477.528286510023;13502.257375844325;13929.164250145024;10295.279330446872;11308.434578271135;11482.253653512495;11492.942535287353;11615.825762613567;3907.240177439776;3948.4274780157;3976.940345894814;4000.9199816003807;4033.193361327746;49190.75404622954;50259.497405025846;52487.475125249024;53529.1970620441;53651;10857.185711071701;10916.126709863192;10932.56269749217;10947.34315941046;11140.997310242117;19655.508612284808;19815.207391704458;19850.1067451965;19982.90008549948;19995.200191992157;7968.203179681986;8309;8386.748397548083;8400.201980811813;8447.366447516339;4663.673542851968;4692.95307046932;4805.13507568641;4805.8077676892535;4820.39745031871;3219.6136463624516;3241.7406607471817;3253.7397008239286;3258.446064169097;3264.8041117533025;584.9093390524475;600.948919341852;605.340179204669;614.8800983808204;615.031325662084;581.5405829394731;721.6824597177225;738.5384134915678;738.6491416577082;757.0990521279659;8049.073156644654;8750.737477875675;8791.384603077851;8939.106089391009;8946.552672366355;748.559320355663;749.1384907356584;753.3935182178399;755.7279379423403;765.3150430364792;3711.6473934976134;4106.609872062149;4136.21411931732;4186.665066794649;4251.29853574163;61217.38782612206;61555.38444615586;61857.69071154615;61891.690541547;61896;53176.46823531792;54000.45999539954;54220.45779542233;54222;54246.728766356704;45903.31145032827;46335.536644633794;47885;47953.040939181024;48511.5148848507;8885.4668719877;9002.954985225031;9182.678606249017;9235.26117910552;9640.855387169058;36802.8159859199;37272.62727372692;37950.43074353942;38093.4285985716;38164;46483;46488.53511464842;46947.765261173474;46956.295655564514;46981.2952805715;11757.294562326288;11824.645260642195;11856.940715296369;11900.226485278428;11996.940015299868;13139.080264381784;13254.072214944861;13512.527061552799;13537.59387218385;13575.049746517649;11776.941115294369;11894.583689570823;11899;12410.441530131346;13081.149725267827;11099.278546894426;11499.827502587636;11846.99300559462;12337.49453345531;12350.135490515577;10136.949315253376;10267.94866025665;10311.432871191857;10473.842892356774;11874.228175168586;9935.354201976848;9944.950275248866;10030.448325342177;10063.39619622825;10612.575496980035;9337.953310233677;9929.205663547044;10197.082262596105;10212.336198147097;10218.54016569271 07:46:13 INFO - 2016-02-04 07:46:13,901 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:46:13 INFO - 2016-02-04 07:46:13,901 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:46:13 INFO - 2016-02-04 07:46:13,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,822 07:46:13 INFO - 2016-02-04 07:46:13,901 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: __startTimestamp1454600773892__endTimestamp 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5645.10 Median:5822.21 stddev:643.18 (11.0%) stddev-sans-first:619.23 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: Values: 3340.5 3411.4 3436.8 3439.6 3464.3 5645.8 5680.9 5698.8 5705.4 5707.6 5698.9 5753.7 5780.1 5781.9 5797.7 4972.9 5035.6 5230.6 5254.5 5328.5 5194.7 5203.9 5209.0 5214.6 5215.3 5101.1 5120.3 5207.2 5228.8 5241.1 5125.1 5131.7 5132.8 5138.9 5140.0 5061.5 5100.1 5167.4 5186.6 5205.5 5186.0 5307.2 5314.4 5451.0 5460.3 6061.2 6174.1 6177.0 6178.4 6181.4 5753.7 6222.7 6229.8 6233.4 6238.9 5597.8 5648.9 5665.2 5671.5 5700.9 6089.4 6122.8 6136.3 6138.8 6163.4 5795.7 5927.7 5960.6 5971.6 5977.1 6068.3 6158.0 6164.2 6166.2 6167.9 6095.5 6096.5 6098.0 6112.3 6127.0 5856.7 5944.2 6007.1 6137.7 6143.9 4607.5 4607.9 4608.0 4608.4 4610.4 4091.7 4144.9 4149.2 4157.1 4159.3 5789.4 5795.9 5801.0 5811.5 5822.2 5912.7 6125.7 6160.3 6173.2 6198.2 5606.8 5610.2 5710.7 5729.3 5770.5 5114.7 5133.5 5163.0 5169.5 5172.7 5999.3 6173.4 6337.9 6341.8 6346.6 6092.2 6138.0 6179.4 6189.3 6207.2 6311.4 6358.0 6365.0 6372.3 6379.6 5661.4 5772.6 6020.0 6113.6 6119.1 6153.7 6191.1 6205.1 6206.8 6206.9 6010.6 6031.1 6037.9 6040.6 6061.5 5716.5 5864.2 5882.8 5958.2 6000.7 5847.6 5873.7 5880.1 5880.3 5880.5 5952.6 6006.7 6009.0 6011.2 6016.0 5669.2 5760.0 5779.4 5868.5 5873.4 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,902 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48225.27 Median:33614.66 stddev:79791.79 (237.4%) stddev-sans-first:79935.43 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: Values: 579.4 625.0 632.4 645.3 649.7 33699.3 41631.6 41981.8 42098.0 42289.8 45369.3 46040.5 46097.5 46131.5 46152.1 8127.1 8258.9 8964.5 9143.9 10293.0 10459.7 10481.6 10551.3 10568.5 10573.3 10607.0 10702.1 10705.6 10707.0 10710.1 10556.4 10634.8 10648.2 10655.8 10656.3 10388.6 10539.3 10541.9 10543.5 10545.6 41489.0 41965.0 41966.0 41977.6 42016.8 3689.8 4112.7 4119.2 4139.7 4274.0 31621.2 32045.7 32384.7 32559.8 32815.2 4173.3 4304.2 4306.0 4326.8 4346.5 297350.0 298193.0 298356.0 299274.0 301173.0 59899.1 60866.7 60996.4 68597.7 69582.7 62260.0 62487.4 62819.7 62892.1 62927.0 17420.1 17530.1 17621.0 17627.1 17651.8 13632.7 13778.3 13790.4 13792.1 13969.2 19956.9 20206.7 20273.7 20281.4 20285.0 7546.3 7708.4 7778.2 7781.7 7807.7 985.1 994.7 1013.7 1110.9 1129.5 27099.2 27531.9 27710.3 27787.2 28095.6 924.6 1077.6 1130.6 1131.0 1145.8 12790.6 13364.5 13465.5 14899.7 15272.4 344387.0 348602.0 349336.0 354162.0 354465.0 52388.7 52533.0 52655.5 52657.7 52670.7 1482.6 1483.3 1488.4 1491.2 1498.7 26124.5 28432.6 28614.7 29113.3 29287.1 48507.5 48966.5 48982.0 49000.5 49018.8 259453.0 259540.0 260700.0 260987.0 261784.0 33309.2 33365.3 33464.3 33694.3 33949.0 43399.8 43743.0 44196.3 44228.0 44412.8 34980.7 35721.8 35921.0 36674.4 37123.6 37313.0 37987.0 39422.8 40249.6 41940.6 33094.8 33535.0 33821.7 34876.8 37932.2 30523.6 30632.1 30851.0 33933.8 33972.5 24677.8 24902.9 25223.1 25279.4 25788.2 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33500.83 Median:13941.80 stddev:104495.72 (749.5%) stddev-sans-first:104759.27 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: Values: 383.3 390.4 392.2 392.3 394.2 15138.2 16135.4 17142.5 18689.6 18700.8 17753.3 18056.5 18139.7 18548.8 18755.3 6200.4 6329.1 6334.9 6340.7 6364.6 4588.6 4733.4 4736.0 6243.9 6719.2 6707.2 6798.0 6808.0 6869.3 6878.0 6737.9 6748.9 6777.7 6781.1 6786.8 6425.6 6474.0 6490.5 6604.5 6608.6 22816.5 23027.3 23040.2 23323.0 23468.4 2493.8 2561.1 2698.8 2714.8 2724.4 14444.9 14689.6 14737.8 14759.6 15004.9 1849.4 1890.6 1968.7 2025.3 2134.4 73253.6 76872.6 78657.0 79577.2 80026.6 15176.8 16000.8 16017.7 16023.1 16026.9 24870.9 24893.0 25284.6 25286.7 25322.5 9695.9 9788.6 9909.6 10022.8 10050.3 8590.1 8608.3 8621.0 8691.1 8712.3 7068.5 7847.2 7985.2 8019.6 8042.6 1887.5 1901.3 1922.2 1936.6 2324.8 913.2 949.5 971.7 1009.4 1028.0 13777.8 13877.3 16191.9 16699.7 17061.6 923.3 986.3 987.0 993.5 1051.2 9627.1 9796.4 9804.4 9904.8 9994.0 621967.0 622025.8 638542.0 658122.0 658647.0 81897.0 83808.0 85410.0 85466.6 85555.0 1171.9 1173.7 1188.2 1189.1 1202.0 15753.6 15779.2 15804.4 16049.3 16191.8 35832.8 36105.5 36482.3 36918.8 37545.4 47335.0 50075.0 50236.7 50329.5 52752.0 9507.3 9543.0 9636.4 10046.1 10067.6 11897.0 11971.9 13747.7 15215.9 15373.0 14553.9 14601.4 14959.2 15255.9 15445.1 13949.3 14511.2 14802.0 15155.9 15244.8 14678.5 14889.6 15138.2 15232.0 15611.5 9708.3 9753.9 10012.0 10019.5 10077.9 15165.4 15330.0 15426.8 15440.3 15688.8 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5395.53 Median:6260.91 stddev:2686.85 (42.9%) stddev-sans-first:2678.57 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: Values: 1516.4 1747.0 1752.5 1783.6 1799.4 7211.9 7559.5 7571.6 7575.3 7577.5 6730.2 6830.4 7336.4 7523.3 7555.1 2298.6 2304.5 2331.1 2333.3 2335.1 2084.1 2323.2 2359.9 2360.8 2361.3 1933.4 2305.3 2341.7 2341.9 2343.2 2255.4 2299.1 2300.7 2316.9 2332.0 2324.7 2328.7 2353.0 2353.9 2392.2 7579.5 7696.9 7697.7 7698.6 7699.6 4657.4 4798.8 4799.1 4801.1 4801.8 3158.1 3180.9 3186.5 3210.1 3254.8 1084.2 1100.6 1140.2 1930.4 1965.4 10160.8 10179.9 10267.7 10343.1 10395.3 4177.1 4181.0 4265.2 4277.9 4285.7 8542.3 8586.8 8604.6 8614.2 8615.9 4817.0 4824.3 4826.3 4828.5 4831.1 4483.3 4488.9 4491.8 4493.5 4493.9 3478.4 3512.0 3530.4 3537.4 3565.3 1063.6 1064.4 1078.5 1089.3 1101.6 1149.1 1153.2 1157.0 1167.0 1190.4 7085.1 7094.6 7240.7 7301.0 7313.2 1064.7 1113.4 1167.2 1174.1 1178.9 5904.6 5914.5 5956.3 5963.1 5964.3 8671.8 8793.8 8913.7 8936.2 8944.2 9148.3 9154.1 9156.3 9274.5 9286.4 6954.3 7008.6 7058.5 7131.1 7139.8 7297.1 7370.4 7372.2 7377.6 7381.3 8148.5 8168.2 8359.3 8368.2 8393.8 8318.4 8343.3 8473.4 8505.8 8512.0 6447.2 6625.6 6637.7 6643.2 6659.4 7128.8 7146.2 7198.5 7200.5 7202.8 6074.6 6590.0 6773.5 6829.5 6928.1 6892.2 6901.7 6946.8 6976.8 7022.2 6959.1 7072.0 7096.5 7103.0 7107.3 6546.3 6570.0 6577.0 6581.1 6582.6 6449.5 6480.3 6594.4 6598.0 6616.3 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,905 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5489.60 Median:6305.07 stddev:1670.03 (26.5%) stddev-sans-first:1629.41 07:46:13 INFO - 2016-02-04 07:46:13,906 DEBUG : BROWSER_OUTPUT: Values: 341.9 343.8 346.8 348.1 354.1 6089.2 6130.6 6237.4 6251.5 6276.4 5828.2 5913.6 5954.6 6113.7 6136.7 4738.5 4738.6 4759.1 4767.0 4780.9 4531.4 4754.4 4757.1 4761.9 4772.9 4601.0 4618.6 4733.5 4738.3 4743.0 4714.8 4721.9 4724.0 4727.0 4727.2 4157.1 4159.1 4162.7 4164.1 4167.5 5734.6 5837.5 5841.2 5842.5 5848.0 5380.9 5386.9 5388.5 5397.1 5399.7 6549.7 6551.9 6557.9 6560.1 6563.2 4438.5 4443.3 4443.7 4445.9 4446.4 6633.4 6697.2 6743.3 6753.1 6755.5 4594.3 4594.7 4596.9 4598.7 4599.2 4660.9 4668.1 4675.5 4675.7 4676.9 5413.9 5422.5 5434.6 5436.7 5441.2 6420.2 6568.4 6568.8 6571.3 6572.9 1619.2 1645.0 1646.2 1646.6 1646.6 1054.9 1078.4 1084.7 1091.0 1110.2 6353.9 6363.0 6372.6 6379.7 6385.7 6588.1 6792.3 6797.7 6811.0 6813.9 6315.7 6328.9 6355.1 6443.5 6451.7 3656.6 3697.7 3703.2 3707.1 3709.2 6886.3 7035.9 7039.1 7040.3 7041.4 7062.7 7067.8 7073.4 7076.0 7077.4 7062.2 7070.1 7071.4 7071.6 7075.5 6683.7 6889.2 6892.8 6895.4 6897.0 6768.6 6790.3 6793.6 6801.7 6805.7 7048.1 7059.0 7069.1 7071.3 7074.0 4517.0 4581.1 4614.2 4619.9 4665.5 6736.8 6811.2 6813.1 6813.4 6814.7 6612.3 6618.2 6620.6 6621.7 6628.7 6453.8 6585.2 6594.8 6600.1 6601.2 6471.0 6484.5 6492.0 6499.9 6502.3 6596.8 6606.9 6608.9 6614.2 6615.7 6294.5 6362.3 6460.8 6461.7 6473.4 07:46:13 INFO - 2016-02-04 07:46:13,906 DEBUG : BROWSER_OUTPUT: 07:46:13 INFO - 2016-02-04 07:46:13,906 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14678.76 Median:4678.31 stddev:16874.78 (360.7%) stddev-sans-first:16890.03 07:46:13 INFO - 2016-02-04 07:46:13,906 DEBUG : BROWSER_OUTPUT: Values: 819.2 893.8 895.0 916.2 921.5 13819.8 14157.2 14162.4 14173.7 14204.1 12902.9 15466.8 15510.0 15541.1 15939.8 761.6 767.7 915.3 918.0 931.2 923.8 924.1 932.9 932.9 933.5 947.4 952.6 955.9 956.5 957.9 931.5 931.7 936.8 939.5 939.9 696.1 697.3 697.6 698.6 698.7 14750.4 14796.7 14800.6 14823.3 14958.3 13419.4 13449.8 13477.5 13502.3 13929.2 10295.3 11308.4 11482.3 11492.9 11615.8 3907.2 3948.4 3976.9 4000.9 4033.2 49190.8 50259.5 52487.5 53529.2 53651.0 10857.2 10916.1 10932.6 10947.3 11141.0 19655.5 19815.2 19850.1 19982.9 19995.2 7968.2 8309.0 8386.7 8400.2 8447.4 4663.7 4693.0 4805.1 4805.8 4820.4 3219.6 3241.7 3253.7 3258.4 3264.8 584.9 600.9 605.3 614.9 615.0 581.5 721.7 738.5 738.6 757.1 8049.1 8750.7 8791.4 8939.1 8946.6 748.6 749.1 753.4 755.7 765.3 3711.6 4106.6 4136.2 4186.7 4251.3 61217.4 61555.4 61857.7 61891.7 61896.0 53176.5 54000.5 54220.5 54222.0 54246.7 45903.3 46335.5 47885.0 47953.0 48511.5 8885.5 9003.0 9182.7 9235.3 9640.9 36802.8 37272.6 37950.4 38093.4 38164.0 46483.0 46488.5 46947.8 46956.3 46981.3 11757.3 11824.6 11856.9 11900.2 11996.9 13139.1 13254.1 13512.5 13537.6 13575.0 11776.9 11894.6 11899.0 12410.4 13081.1 11099.3 11499.8 11847.0 12337.5 12350.1 10136.9 10267.9 10311.4 10473.8 11874.2 9935.4 9945.0 10030.4 10063.4 10612.6 9338.0 9929.2 10197.1 10212.3 10218.5 07:46:13 INFO - 2016-02-04 07:46:13,906 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:46:13 INFO - 2016-02-04 07:46:13,906 DEBUG : BROWSER_OUTPUT: 07:46:14 INFO - 2016-02-04 07:46:14,445 INFO : Browser exited with error code: 0 07:46:14 INFO - 2016-02-04 07:46:14,466 INFO : Completed test dromaeo_css (00:18:30) 07:46:14 INFO - 2016-02-04 07:46:14,466 INFO : Starting test kraken 07:46:14 INFO - 2016-02-04 07:46:14,466 DEBUG : operating with platform_type : linux_ 07:46:14 INFO - 2016-02-04 07:46:14,466 INFO : Initialising browser for kraken test... 07:46:14 INFO - 2016-02-04 07:46:14,472 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8vWwoj/profile http://localhost:58415/getInfo.html 07:46:18 INFO - 2016-02-04 07:46:18,109 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:46:18 INFO - 2016-02-04 07:46:18,109 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:46:18 INFO - 2016-02-04 07:46:18,109 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:46:18 INFO - 2016-02-04 07:46:18,109 DEBUG : BROWSER_OUTPUT: __metrics 07:46:18 INFO - 2016-02-04 07:46:18,359 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] 07:46:19 INFO - 2016-02-04 07:46:19,142 INFO : Browser initialized. 07:46:19 INFO - 2016-02-04 07:46:19,143 INFO : Running cycle 1/1 for kraken test... 07:46:19 INFO - 2016-02-04 07:46:19,143 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8vWwoj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:46:30 INFO - 2016-02-04 07:46:30,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 134791168 07:46:30 INFO - 2016-02-04 07:46:30,878 DEBUG : BROWSER_OUTPUT: 07:46:33 INFO - 2016-02-04 07:46:33,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58415/tests/kraken/driver.html?testName=audio-beat-detection) 07:46:33 INFO - 2016-02-04 07:46:33,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 164638720 07:46:33 INFO - 2016-02-04 07:46:33,875 DEBUG : BROWSER_OUTPUT: 07:46:36 INFO - 2016-02-04 07:46:36,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58415/tests/kraken/driver.html?testName=audio-dft) 07:46:36 INFO - 2016-02-04 07:46:36,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 161488896 07:46:36 INFO - 2016-02-04 07:46:36,996 DEBUG : BROWSER_OUTPUT: 07:46:39 INFO - 2016-02-04 07:46:39,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58415/tests/kraken/driver.html?testName=audio-fft) 07:46:40 INFO - 2016-02-04 07:46:40,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 160006144 07:46:40 INFO - 2016-02-04 07:46:40,325 DEBUG : BROWSER_OUTPUT: 07:46:42 INFO - 2016-02-04 07:46:42,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58415/tests/kraken/driver.html?testName=audio-oscillator) 07:46:42 INFO - 2016-02-04 07:46:42,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 160018432 07:46:42 INFO - 2016-02-04 07:46:42,832 DEBUG : BROWSER_OUTPUT: 07:46:45 INFO - 2016-02-04 07:46:45,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:46:45 INFO - 2016-02-04 07:46:45,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 159363072 07:46:45 INFO - 2016-02-04 07:46:45,577 DEBUG : BROWSER_OUTPUT: 07:46:48 INFO - 2016-02-04 07:46:48,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58415/tests/kraken/driver.html?testName=imaging-darkroom) 07:46:48 INFO - 2016-02-04 07:46:48,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 159129600 07:46:48 INFO - 2016-02-04 07:46:48,995 DEBUG : BROWSER_OUTPUT: 07:46:52 INFO - 2016-02-04 07:46:52,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58415/tests/kraken/driver.html?testName=imaging-desaturate) 07:46:52 INFO - 2016-02-04 07:46:52,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 160649216 07:46:52 INFO - 2016-02-04 07:46:52,823 DEBUG : BROWSER_OUTPUT: 07:46:55 INFO - 2016-02-04 07:46:55,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58415/tests/kraken/driver.html?testName=json-parse-financial) 07:46:56 INFO - 2016-02-04 07:46:56,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 159055872 07:46:56 INFO - 2016-02-04 07:46:56,050 DEBUG : BROWSER_OUTPUT: 07:46:57 INFO - 2016-02-04 07:46:57,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:46:58 INFO - 2016-02-04 07:46:58,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 165998592 07:46:58 INFO - 2016-02-04 07:46:58,152 DEBUG : BROWSER_OUTPUT: 07:46:59 INFO - 2016-02-04 07:46:59,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:00 INFO - 2016-02-04 07:47:00,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 164626432 07:47:00 INFO - 2016-02-04 07:47:00,477 DEBUG : BROWSER_OUTPUT: 07:47:02 INFO - 2016-02-04 07:47:02,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:03 INFO - 2016-02-04 07:47:03,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 167522304 07:47:03 INFO - 2016-02-04 07:47:03,049 DEBUG : BROWSER_OUTPUT: 07:47:05 INFO - 2016-02-04 07:47:05,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:06 INFO - 2016-02-04 07:47:06,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 174604288 07:47:06 INFO - 2016-02-04 07:47:06,016 DEBUG : BROWSER_OUTPUT: 07:47:08 INFO - 2016-02-04 07:47:08,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:09 INFO - 2016-02-04 07:47:09,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 171941888 07:47:09 INFO - 2016-02-04 07:47:09,114 DEBUG : BROWSER_OUTPUT: 07:47:10 INFO - 2016-02-04 07:47:10,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58415/tests/kraken/driver.html?testName=ai-astar) 07:47:11 INFO - 2016-02-04 07:47:11,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 231346176 07:47:11 INFO - 2016-02-04 07:47:11,014 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,015 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:47:11 INFO - 2016-02-04 07:47:11,015 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:47:11 INFO - 2016-02-04 07:47:11,015 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:47:11 INFO - 2016-02-04 07:47:11,016 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:47:11 INFO - 2016-02-04 07:47:11,016 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;109;109;110;100;109;109;109 07:47:11 INFO - 2016-02-04 07:47:11,016 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;121;142;157;127;154;150;123;171;123 07:47:11 INFO - 2016-02-04 07:47:11,016 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;162;160;161;161;160;159;158 07:47:11 INFO - 2016-02-04 07:47:11,016 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;71;144;73;71;72;71;151;72 07:47:11 INFO - 2016-02-04 07:47:11,017 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;140;93;92;93;133;93;92;132 07:47:11 INFO - 2016-02-04 07:47:11,017 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;110;109 07:47:11 INFO - 2016-02-04 07:47:11,017 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;144;144;145;145;145;146;147 07:47:11 INFO - 2016-02-04 07:47:11,017 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;95 07:47:11 INFO - 2016-02-04 07:47:11,017 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;58;60;60;58;58;57;57;55;57 07:47:11 INFO - 2016-02-04 07:47:11,017 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;62;62;64;62;63;62;62;62 07:47:11 INFO - 2016-02-04 07:47:11,018 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;78;80;87;78;78;87;79;78 07:47:11 INFO - 2016-02-04 07:47:11,019 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;118;117;111;117;121;133;112;111;112 07:47:11 INFO - 2016-02-04 07:47:11,019 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;150;145;156;146;134;149;145;146;138 07:47:11 INFO - 2016-02-04 07:47:11,019 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;69;67;65;65;64;65;63;67;71 07:47:11 INFO - 2016-02-04 07:47:11,019 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:47:11 INFO - 2016-02-04 07:47:11,019 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:47:11 INFO - 2016-02-04 07:47:11,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,878 07:47:11 INFO - 2016-02-04 07:47:11,020 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:47:11 INFO - 2016-02-04 07:47:11,020 DEBUG : BROWSER_OUTPUT: __startTimestamp1454600831014__endTimestamp 07:47:11 INFO - 2016-02-04 07:47:11,020 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:47:11 INFO - 2016-02-04 07:47:11,024 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:47:11 INFO - 2016-02-04 07:47:11,024 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,024 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.31 (3.0%) stddev-sans-first:3.49 07:47:11 INFO - 2016-02-04 07:47:11,024 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 109.0 109.0 110.0 100.0 109.0 109.0 109.0 07:47:11 INFO - 2016-02-04 07:47:11,024 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,025 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:148.00 stddev:17.24 (11.6%) stddev-sans-first:18.20 07:47:11 INFO - 2016-02-04 07:47:11,025 DEBUG : BROWSER_OUTPUT: Values: 146.0 121.0 142.0 157.0 127.0 154.0 150.0 123.0 171.0 123.0 07:47:11 INFO - 2016-02-04 07:47:11,025 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,025 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 07:47:11 INFO - 2016-02-04 07:47:11,025 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 162.0 160.0 161.0 161.0 160.0 159.0 158.0 07:47:11 INFO - 2016-02-04 07:47:11,025 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,026 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.80 Median:71.50 stddev:32.04 (44.8%) stddev-sans-first:33.47 07:47:11 INFO - 2016-02-04 07:47:11,026 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 144.0 73.0 71.0 72.0 71.0 151.0 72.0 07:47:11 INFO - 2016-02-04 07:47:11,026 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,026 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:93.00 stddev:20.47 (22.0%) stddev-sans-first:21.20 07:47:11 INFO - 2016-02-04 07:47:11,026 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 140.0 93.0 92.0 93.0 133.0 93.0 92.0 132.0 07:47:11 INFO - 2016-02-04 07:47:11,026 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,027 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:47:11 INFO - 2016-02-04 07:47:11,027 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 07:47:11 INFO - 2016-02-04 07:47:11,027 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,027 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 07:47:11 INFO - 2016-02-04 07:47:11,027 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 144.0 144.0 145.0 145.0 145.0 146.0 147.0 07:47:11 INFO - 2016-02-04 07:47:11,027 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,028 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:47:11 INFO - 2016-02-04 07:47:11,028 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 07:47:11 INFO - 2016-02-04 07:47:11,028 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,028 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:1.72 (3.0%) stddev-sans-first:1.56 07:47:11 INFO - 2016-02-04 07:47:11,028 DEBUG : BROWSER_OUTPUT: Values: 55.0 58.0 60.0 60.0 58.0 58.0 57.0 57.0 55.0 57.0 07:47:11 INFO - 2016-02-04 07:47:11,028 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,029 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 07:47:11 INFO - 2016-02-04 07:47:11,029 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 62.0 62.0 64.0 62.0 63.0 62.0 62.0 62.0 07:47:11 INFO - 2016-02-04 07:47:11,029 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,029 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:78.50 stddev:3.84 (4.9%) stddev-sans-first:3.93 07:47:11 INFO - 2016-02-04 07:47:11,029 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 78.0 80.0 87.0 78.0 78.0 87.0 79.0 78.0 07:47:11 INFO - 2016-02-04 07:47:11,029 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:117.00 stddev:6.63 (5.7%) stddev-sans-first:7.03 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: Values: 116.0 118.0 117.0 111.0 117.0 121.0 133.0 112.0 111.0 112.0 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:146.00 stddev:6.31 (4.3%) stddev-sans-first:6.44 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: Values: 140.0 150.0 145.0 156.0 146.0 134.0 149.0 145.0 146.0 138.0 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.41 (3.6%) stddev-sans-first:2.54 07:47:11 INFO - 2016-02-04 07:47:11,030 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 65.0 65.0 64.0 65.0 63.0 67.0 71.0 07:47:11 INFO - 2016-02-04 07:47:11,031 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:47:11 INFO - 2016-02-04 07:47:11,031 DEBUG : BROWSER_OUTPUT: 07:47:11 INFO - 2016-02-04 07:47:11,741 INFO : Browser exited with error code: 0 07:47:11 INFO - 2016-02-04 07:47:11,789 INFO : Completed test kraken (00:00:57) 07:47:11 INFO - 2016-02-04 07:47:11,789 INFO : Starting test v8_7 07:47:11 INFO - 2016-02-04 07:47:11,789 DEBUG : operating with platform_type : linux_ 07:47:11 INFO - 2016-02-04 07:47:11,789 INFO : Initialising browser for v8_7 test... 07:47:11 INFO - 2016-02-04 07:47:11,795 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJz6gzy/profile http://localhost:58415/getInfo.html 07:47:15 INFO - 2016-02-04 07:47:15,327 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:47:15 INFO - 2016-02-04 07:47:15,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:47:15 INFO - 2016-02-04 07:47:15,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:47:15 INFO - 2016-02-04 07:47:15,327 DEBUG : BROWSER_OUTPUT: __metrics 07:47:15 INFO - 2016-02-04 07:47:15,472 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] 07:47:16 INFO - 2016-02-04 07:47:16,365 INFO : Browser initialized. 07:47:16 INFO - 2016-02-04 07:47:16,366 INFO : Running cycle 1/1 for v8_7 test... 07:47:16 INFO - 2016-02-04 07:47:16,366 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJz6gzy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:47:28 INFO - 2016-02-04 07:47:28,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 134352896 07:47:28 INFO - 2016-02-04 07:47:28,105 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58415/tests/v8_7/run.html (next: http://localhost:58415/tests/v8_7/run.html) 07:47:49 INFO - 2016-02-04 07:47:49,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 423649280 07:47:49 INFO - 2016-02-04 07:47:49,722 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,722 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:47:49 INFO - 2016-02-04 07:47:49,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:47:49 INFO - 2016-02-04 07:47:49,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:47:49 INFO - 2016-02-04 07:47:49,722 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:47:49 INFO - 2016-02-04 07:47:49,722 DEBUG : BROWSER_OUTPUT: |0;Richards;168.29350387075058 07:47:49 INFO - 2016-02-04 07:47:49,723 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.41959881617888 07:47:49 INFO - 2016-02-04 07:47:49,723 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 07:47:49 INFO - 2016-02-04 07:47:49,723 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 07:47:49 INFO - 2016-02-04 07:47:49,723 DEBUG : BROWSER_OUTPUT: |4;RayTrace;939.8496240601504 07:47:49 INFO - 2016-02-04 07:47:49,723 DEBUG : BROWSER_OUTPUT: |5;Earley;547.0459518599563 07:47:49 INFO - 2016-02-04 07:47:49,723 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 07:47:49 INFO - 2016-02-04 07:47:49,723 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 07:47:49 INFO - 2016-02-04 07:47:49,724 DEBUG : BROWSER_OUTPUT: |8;Splay;530.5039787798408 07:47:49 INFO - 2016-02-04 07:47:49,724 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 07:47:49 INFO - 2016-02-04 07:47:49,725 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:47:49 INFO - 2016-02-04 07:47:49,725 DEBUG : BROWSER_OUTPUT: __startTimestamp1454600869721__endTimestamp 07:47:49 INFO - 2016-02-04 07:47:49,726 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,726 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:47:49 INFO - 2016-02-04 07:47:49,726 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:47:49 INFO - 2016-02-04 07:47:49,726 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,726 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.29 Median:168.29 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,727 DEBUG : BROWSER_OUTPUT: Values: 168.3 07:47:49 INFO - 2016-02-04 07:47:49,727 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,727 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.42 Median:164.42 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,727 DEBUG : BROWSER_OUTPUT: Values: 164.4 07:47:49 INFO - 2016-02-04 07:47:49,727 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,727 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,728 DEBUG : BROWSER_OUTPUT: Values: 279.0 07:47:49 INFO - 2016-02-04 07:47:49,728 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,728 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,728 DEBUG : BROWSER_OUTPUT: Values: 5175.3 07:47:49 INFO - 2016-02-04 07:47:49,728 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,728 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:939.85 Median:939.85 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: Values: 939.8 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.05 Median:547.05 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: Values: 547.0 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: Values: 10526.3 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,729 DEBUG : BROWSER_OUTPUT: Values: 24238.1 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:530.50 Median:530.50 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: Values: 530.5 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: Values: 4826.9 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:47:49 INFO - 2016-02-04 07:47:49,730 DEBUG : BROWSER_OUTPUT: 07:47:50 INFO - 2016-02-04 07:47:50,413 INFO : Browser exited with error code: 0 07:47:50 INFO - 2016-02-04 07:47:50,427 INFO : Completed test v8_7 (00:00:38) 07:47:50 INFO - 2016-02-04 07:47:50,784 INFO : Completed test suite (00:20:06) 07:47:50 INFO - 2016-02-04 07:47:50,784 DEBUG : Working with test: dromaeo_css 07:47:50 INFO - 2016-02-04 07:47:50,784 DEBUG : Generating results file: dromaeo_css 07:47:50 INFO - 2016-02-04 07:47:50,786 DEBUG : Working with test: kraken 07:47:50 INFO - 2016-02-04 07:47:50,786 DEBUG : Generating results file: kraken 07:47:50 INFO - 2016-02-04 07:47:50,786 INFO : javascript benchmark 07:47:50 INFO - 2016-02-04 07:47:50,786 DEBUG : Working with test: v8_7 07:47:50 INFO - 2016-02-04 07:47:50,786 DEBUG : Generating results file: v8_7 07:47:50 INFO - 2016-02-04 07:47:50,787 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:47:50 INFO - 2016-02-04 07:47:50,845 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 07:47:50 INFO - 2016-02-04 07:47:50,845 DEBUG : process_Request line: dromaeo_css 7435.85 graph.html#tests=[[72,53,35]] 07:47:50 INFO - 2016-02-04 07:47:50,845 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:47:50 INFO - 2016-02-04 07:47:50,878 DEBUG : process_Request line: kraken 1479.50 graph.html#tests=[[232,53,35]] 07:47:50 INFO - 2016-02-04 07:47:50,878 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:47:50 INFO - 2016-02-04 07:47:50,913 DEBUG : process_Request line: v8_7 23260.45 graph.html#tests=[[230,53,35]] 07:47:50 INFO - 2016-02-04 07:47:50,914 INFO : javascript benchmark 07:47:50 INFO - 2016-02-04 07:47:50,917 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3340.515625234341, 3411.351843149803, 3436.810975396352, 3439.604445488768, 3464.324456730937, 5645.802396916109, 5680.914786278209, 5698.772049118031, 5705.400932902048, 5707.600467967244, 5698.943010569893, 5753.741081651326, 5780.0751879699155, 5781.913271300934, 5797.739101740422, 4972.875678108058, 5035.62232832539, 5230.633855630107, 5254.474552544753, 5328.46715328468, 5194.662346947455, 5203.86990325243, 5209.036328279261, 5214.608904332172, 5215.295935048777, 5101.081805275049, 5120.257562653413, 5207.218917162418, 5228.764705588239, 5241.135212689902, 5125.077486052509, 5131.743412829381, 5132.8460146195675, 5138.922916156261, 5140.023395554851, 5061.468545802712, 5100.056489549445, 5167.354080739908, 5186.636935414523, 5205.479452054764, 5186.040582492251, 5307.177387504943, 5314.362276526803, 5451.0, 5460.26286451328, 6061.181740465025, 6174.104754810527, 6177.042558403455, 6178.351273116303, 6181.3818618138275, 5753.712314384264, 6222.657753823538, 6229.813105606794, 6233.438990490832, 6238.9376106238815, 5597.804076857331, 5648.887022259573, 5665.178549110356, 5671.461211184931, 5700.942990570083, 6089.360617135137, 6122.816315510542, 6136.294326152461, 6138.785142519991, 6163.38366163389, 5795.710214489343, 5927.673977931255, 5960.552958528127, 5971.611845230133, 5977.073553599199, 6068.302145253352, 6158.04550294705, 6164.229471316085, 6166.167567378347, 6167.938320616737, 6095.512359011357, 6096.512279017668, 6097.969510152421, 6112.327643959161, 6127.019676851772, 5856.736446859902, 5944.167816505693, 6007.068904319837, 6137.723802428902, 6143.907841382383, 4607.539246075433, 4607.9308810367875, 4607.953920460753, 4608.446986361591, 4610.446746390455, 4091.7340372876265, 4144.896377590524, 4149.190907772955, 4157.064660451435, 4159.272127377697, 5789.363170051291, 5795.855103622359, 5801.042827933428, 5811.535077193815, 5822.214001109881, 5912.674802885796, 6125.693715314216, 6160.260768707783, 6173.166622505904, 6198.163247961467, 5606.775728970877, 5610.158476228598, 5710.71446427677, 5729.28383952006, 5770.451807078321, 5114.71869047206, 5133.486651334912, 5163.0, 5169.53474187325, 5172.689638621695, 5999.310079340931, 6173.444390005011, 6337.8732425352155, 6341.778037768656, 6346.587471814318, 6092.238470191226, 6138.02057325484, 6179.443850053517, 6189.288231853395, 6207.224096987877, 6311.431971122621, 6357.96821015892, 6364.968175159094, 6372.299047104722, 6379.553431259953, 5661.377248502579, 5772.56705747079, 6020.0, 6113.633182008915, 6119.051547010221, 6153.72308246139, 6191.102290167991, 6205.131281620486, 6206.813795586139, 6206.937930620636, 6010.609310394811, 6031.089730847243, 6037.909431358621, 6040.637561746309, 6061.454469097803, 5716.514096301861, 5864.179014937998, 5882.794102206402, 5958.225430693982, 6000.669963152069, 5847.590668653153, 5873.706314684334, 5880.088586269135, 5880.294364676266, 5880.500157486662, 5952.58331916779, 6006.669633170043, 6009.038553831366, 6011.158437818796, 6016.0, 5669.177969194361, 5760.049591817303, 5779.364269930388, 5868.471837534642, 5873.4126587340925], "unit": "ms", "name": "dojo.html", "value": 5602.853389389608}, {"lowerIsBetter": false, "replicates": [579.3569138256535, 624.9906251406228, 632.4371309534514, 645.303072681504, 649.6978904809263, 33699.326013479746, 41631.583684163146, 41981.79009104958, 42098.0, 42289.78855105724, 45369.31946020812, 46040.539594604044, 46097.539024609745, 46131.538684613144, 46152.07695846081, 8127.146649601796, 8258.917410825905, 8964.462132272085, 9143.908560914406, 10293.0, 10459.686209413692, 10481.633142840003, 10551.261411701145, 10568.471576421187, 10573.312734672221, 10607.0, 10702.090322322612, 10705.571777128944, 10707.036366726992, 10710.143188544936, 10556.419396933166, 10634.840477392845, 10648.201384896087, 10655.78688426231, 10656.254062215608, 10388.584456621726, 10539.262251642389, 10541.947290263499, 10543.52554135058, 10545.578176872992, 41489.0, 41965.0, 41966.0, 41977.58022419767, 42016.78991605053, 3689.8339574719203, 4112.691548133902, 4119.196756632457, 4139.689523285735, 4274.038341373197, 31621.20946976344, 32045.679543204737, 32384.676153238637, 32559.837200813843, 32815.179620509676, 4173.3114036184, 4304.182205380967, 4306.0, 4326.832508749854, 4346.521882592912, 297350.0, 298193.0, 298356.0, 299274.0, 301173.0, 59899.10151347733, 60866.69566652139, 60996.390036099074, 68597.65701171462, 69582.65208674026, 62260.0, 62487.43781405501, 62819.6859015702, 62892.056619150746, 62927.0, 17420.128993550527, 17530.123493825256, 17621.0, 17627.118644067745, 17651.82348176502, 13632.65918352049, 13778.311084445737, 13790.448382064606, 13792.103513271806, 13969.23169225682, 19956.90021549883, 20206.696899546518, 20273.695894561297, 20281.391558253275, 20285.0, 7546.2831031051965, 7708.38332933364, 7778.183290754502, 7781.727639532589, 7807.687692492236, 985.103555764251, 994.721477986165, 1013.7313611892854, 1110.8611423572054, 1129.5312445335094, 27099.1870243893, 27531.86049298855, 27710.307242319104, 27787.19383240083, 28095.57856632152, 924.611663101499, 1077.617445806743, 1130.6494986554194, 1130.9547618095185, 1145.7765735681628, 12790.61628151157, 13364.465421383231, 13465.461381544825, 14899.702005960036, 15272.38910443592, 344387.0, 348602.0, 349336.0, 354162.0, 354465.0, 52388.73805630948, 52533.0, 52655.47344526506, 52657.736711316196, 52670.73664631729, 1482.629342664334, 1483.2731961338866, 1488.4418343121329, 1491.1649476293528, 1498.7452133137392, 26124.477510450066, 28432.57351139693, 28614.67378315967, 29113.272168195963, 29287.12138635844, 48507.5149248503, 48966.51033489619, 48982.0, 49000.50999489959, 49018.754906225244, 259453.0, 259540.0, 260700.0, 260987.0, 261784.0, 33309.16727081745, 33365.332693346485, 33464.33071338511, 33694.326113478084, 33949.0, 43399.78300108479, 43743.0, 44196.337054944845, 44228.0, 44412.77793611011, 34980.65019349876, 35721.82139089288, 35921.0, 36674.44988325231, 37123.62876371202, 37313.0, 37987.0, 39422.80288598539, 40249.59750402458, 41940.58059419367, 33094.83452582722, 33535.0, 33821.66178338185, 34876.825615872775, 37932.2413551733, 30523.63153666098, 30632.148591591103, 30851.0, 33933.830330848185, 33972.49041264334, 24677.753222468265, 24902.875485622455, 25223.11719089823, 25279.36801579975, 25788.226353209433], "unit": "ms", "name": "ext.html", "value": 19636.729825830178}, {"lowerIsBetter": false, "replicates": [383.30238965083544, 390.3987858697605, 392.21361170852435, 392.2821237136041, 394.15060544526557, 15138.167400792952, 16135.354585816583, 17142.485725428225, 18689.62620747586, 18700.812991870076, 17753.28986840525, 18056.4583062508, 18139.727904081417, 18548.81451185488, 18755.3435629753, 6200.379962003797, 6329.113924050614, 6334.873302533946, 6340.682965851712, 6364.649944253064, 4588.564086411802, 4733.384659994196, 4736.029114031615, 6243.906341404882, 6719.22728886177, 6707.228668703113, 6798.04827324175, 6807.965960170192, 6869.278725733776, 6877.965610171942, 6737.865242695143, 6748.865022699568, 6777.661116944133, 6781.084553585277, 6786.7963961080995, 6425.646589437579, 6473.9676301618665, 6490.480761539113, 6604.471642268607, 6608.60348379094, 22816.543669126524, 23027.30918072444, 23040.193593224325, 23323.0, 23468.413289667726, 2493.763092506227, 2561.1164148368784, 2698.7571118599226, 2714.782817374605, 2724.441489494649, 14444.92777536116, 14689.559313220621, 14737.778933316009, 14759.557213283511, 15004.924975375163, 1849.3897013985352, 1890.6218756248804, 1968.7145363922293, 2025.2709024751077, 2134.4130364149983, 73253.633731831, 76872.61563692146, 78657.0, 79577.20422795755, 80026.59986700029, 15176.772348414783, 16000.839991600167, 16017.679646407007, 16023.118728469814, 16026.919865400598, 24870.875645622018, 24893.0, 25284.620730689054, 25286.74713252844, 25322.493550129264, 9695.854562181574, 9788.55951482185, 9909.554070066864, 10022.849657255147, 10050.346727462691, 8590.055093939662, 8608.268297194683, 8621.0, 8691.130886911385, 8712.346574006975, 7068.540544864567, 7847.176046515034, 7985.2014798519685, 8019.639116239783, 8042.557659328676, 1887.452638734779, 1901.306023301485, 1922.1926790747918, 1936.5545924437458, 2324.83726139172, 913.1918252346588, 949.4825320200507, 971.6842026341467, 1009.3641006166068, 1028.0, 13777.793333100011, 13877.306134693225, 16191.866569340269, 16699.66600668004, 17061.57346066358, 923.2613908872875, 986.3145114145743, 986.9753256168653, 993.478423827482, 1051.2115913065202, 9627.133557979676, 9796.363236389612, 9804.36271642341, 9904.801903961881, 9994.0, 621967.0, 622025.7716511891, 638542.0, 658122.0, 658647.0, 81897.0, 83808.0, 85410.0, 85466.57266713626, 85554.99999999875, 1171.8652354979115, 1173.7124404520946, 1188.2333004376148, 1189.120051162134, 1202.008343116932, 15753.606159846095, 15779.211039447751, 15804.446844360393, 16049.277782500048, 16191.838081619033, 35832.820835895654, 36105.458418124275, 36482.27035459223, 36918.815405922796, 37545.4368184472, 47335.0, 50075.0, 50236.748816255684, 50329.49670503248, 52752.0, 9507.334486585873, 9543.0, 9636.42181469114, 10046.146077583488, 10067.597296108073, 11897.0, 11971.940140299243, 13747.656308592364, 15215.923920380328, 15373.000754950892, 14553.92723036378, 14601.415943362146, 14959.17724525118, 15255.923720381326, 15445.0732956023, 13949.302534873419, 14511.167046226326, 14802.0, 15155.92422037927, 15244.771328430304, 14678.486252981094, 14889.553313400615, 15138.243087845784, 15232.0, 15611.453599123975, 9708.2718796092, 9753.853692194481, 10012.0, 10019.54912028946, 10077.949610251902, 15165.393384264506, 15330.0, 15426.84573154254, 15440.30518626642, 15688.843111569195], "unit": "ms", "name": "jquery.html", "value": 10150.354629839196}, {"lowerIsBetter": false, "replicates": [1516.416179770788, 1746.9563260918478, 1752.5443384719977, 1783.5630270583708, 1799.3612267644983, 7211.855762884746, 7559.5464272143645, 7571.6214189290595, 7575.280348366903, 7577.545347279167, 6730.192376914765, 6830.385265326119, 7336.4130869530445, 7523.322900938914, 7555.055618047744, 2298.5517824024364, 2304.4699719064624, 2331.067572970808, 2333.276684227886, 2335.065973610561, 2084.062172022596, 2323.2101085630884, 2359.893804778789, 2360.7875291223786, 2361.327021798788, 1933.4489670443927, 2305.296884450242, 2341.7072865891764, 2341.8594884306913, 2343.156463673085, 2255.391044418006, 2299.0803678528555, 2300.7009088818513, 2316.884155792212, 2331.988340058297, 2324.651302304651, 2328.6856274403076, 2352.988235058831, 2353.929382118522, 2392.174699728591, 7579.54522728638, 7696.923030769733, 7697.692092316301, 7698.576578288192, 7699.576523291216, 4657.417822772153, 4798.760061996886, 4799.13615549201, 4801.135795556798, 4801.783919723621, 3158.1315138336913, 3180.904572862818, 3186.5060915558124, 3210.085125739153, 3254.8372581370836, 1084.159776173464, 1100.6312885183472, 1140.236041851961, 1930.3629802165392, 1965.3907288740536, 10160.796784064278, 10179.89820101797, 10267.691969240936, 10343.120834728981, 10395.32430392022, 4177.101923086551, 4181.0, 4265.210935976854, 4277.850275240352, 4285.7000009999, 8542.316614670812, 8586.828263434822, 8604.612792424356, 8614.224719775126, 8615.913840861636, 4817.012512434942, 4824.276358546246, 4826.251930950708, 4828.493008234155, 4831.130396528659, 4483.30508771141, 4488.865334039984, 4491.752953587518, 4493.483249426293, 4493.932591011137, 3478.4434490481403, 3512.0, 3530.382183117944, 3537.398642230827, 3565.2691198304287, 1063.622414043019, 1064.41989115932, 1078.4931082391263, 1089.2810744908481, 1101.6199411203122, 1149.149629274331, 1153.1524329617723, 1156.9826452603218, 1166.953321867133, 1190.422645017166, 7085.078939737904, 7094.645267736696, 7240.746573869889, 7300.96349518249, 7313.2321106284135, 1064.7125276175389, 1113.3709454158375, 1167.2237961755338, 1174.0783484964263, 1178.935158566287, 5904.586678932434, 5914.526837852962, 5956.2852457704485, 5963.105534169909, 5964.314103878023, 8671.783205419788, 8793.780155496035, 8913.732588022369, 8936.24041956428, 8944.195022448012, 9148.2681385489, 9154.084591540792, 9156.267498600097, 9274.536273186313, 9286.442813431217, 6954.3045695430055, 7008.614526201108, 7058.505904586732, 7131.108611423572, 7139.785806425815, 7297.124345078624, 7370.373518251009, 7372.189059203591, 7377.557346559223, 7381.335679788845, 8148.511089334659, 8168.224018718212, 8359.331253499584, 8368.24685778283, 8393.790155246168, 8318.41771076043, 8343.332533397435, 8473.364497662576, 8505.787355316166, 8512.0, 6447.194100737408, 6625.635590042401, 6637.734490620321, 6643.236027856665, 6659.4006539411685, 7128.8217794553475, 7146.249643787535, 7198.49610527258, 7200.531965422231, 7202.819929501804, 6074.635521868702, 6589.967050164719, 6773.458123350021, 6829.52193346461, 6928.1339832520935, 6892.241853396223, 6901.654917254017, 6946.756863509753, 6976.7558135465015, 7022.157341119098, 6959.060526828814, 7071.964640176766, 7096.503244772816, 7102.964485177541, 7107.324804143598, 6546.345365463416, 6569.967150164219, 6577.046328282468, 6581.111549940697, 6582.572132811352, 6449.451796597342, 6480.287168411565, 6594.373534514213, 6598.04328372393, 6616.338366163345], "unit": "ms", "name": "mootools.html", "value": 4508.700353681967}, {"lowerIsBetter": false, "replicates": [341.8837595217626, 343.8401143468287, 346.7780620402941, 348.0723870884094, 354.07586200017965, 6089.238845144357, 6130.570860039794, 6237.376262373766, 6251.4686251668545, 6276.372362763721, 5828.242328497289, 5913.586048976563, 5954.583179177459, 6113.663748493831, 6136.723847426865, 4738.47876733559, 4738.573528382445, 4759.119562880861, 4767.04659068186, 4780.880477988043, 4531.43357080365, 4754.358161648185, 4757.0723708876785, 4761.880952976168, 4772.856814295559, 4600.953990460102, 4618.56123668251, 4733.479317275097, 4738.265568836819, 4743.0, 4714.834980775657, 4721.905561888743, 4724.031573527419, 4726.95273047272, 4727.196376615983, 4157.08544120293, 4159.064210552601, 4162.708610397273, 4164.146349998243, 4167.458230430055, 5734.598578099493, 5837.50381217597, 5841.153032810261, 5842.4741773240185, 5848.035074212749, 5380.946190538084, 5386.91919621202, 5388.461153884619, 5397.136458166714, 5399.70301633414, 6549.705263263165, 6551.868962620769, 6557.868842623168, 6560.147180866505, 6563.245226798931, 4438.467383913919, 4443.33349997503, 4443.7111587746695, 4445.911081778347, 4446.3552784846015, 6633.369829866203, 6697.19633643961, 6743.325667433218, 6753.0545723599225, 6755.459563234929, 4594.33382159585, 4594.724316541018, 4596.885077873013, 4598.701084429501, 4599.241125214369, 4660.906781864343, 4668.066386722669, 4675.462321832964, 4675.696079754805, 4676.906461870743, 5413.918791218135, 5422.457754224546, 5434.64674796137, 5436.728163591804, 5441.156620723794, 6420.1974753155855, 6568.408843204134, 6568.8357791055605, 6571.31001244872, 6572.86854262912, 1619.1742211472233, 1644.9506514804575, 1646.218046427961, 1646.5554300338842, 1646.6048148444288, 1054.9419781911915, 1078.358376765823, 1084.6745976207264, 1090.9727256818644, 1110.1784679337393, 6353.936460635427, 6363.0455431684695, 6372.553921225563, 6379.71291291893, 6385.712642931079, 6588.077669126326, 6792.320767923168, 6797.728090876409, 6811.046453496514, 6813.931860681429, 6315.684215789284, 6328.936710632926, 6355.0785136155, 6443.4523065539015, 6451.741930322734, 3656.5612126544984, 3697.7411581189594, 3703.2408356286896, 3707.1102935295335, 3709.221063576625, 6886.311368863074, 7035.894461583081, 7039.084918960502, 7040.2607726189035, 7041.366277035091, 7062.717491300393, 7067.82330441743, 7073.398761105261, 7075.964620176969, 7077.3984211341585, 7062.223155452896, 7070.116235470567, 7071.398931090812, 7071.611061391673, 7075.504714670026, 6683.665816709048, 6889.2421833599265, 6892.793216203522, 6895.4138898194215, 6896.965515172392, 6768.627725475146, 6790.25307216196, 6793.558418702769, 6801.693923773343, 6805.727770889109, 7048.083749112582, 7058.964705176647, 7069.116360454943, 7071.25751796054, 7073.964630176816, 4516.961098947195, 4581.060882519009, 4614.238650622609, 4619.93070103942, 4665.486796452456, 6736.831579210363, 6811.2167100784045, 6813.1142951415995, 6813.3527314905, 6814.693338799865, 6612.305707900794, 6618.172728408949, 6620.602763834186, 6621.735130594722, 6628.668566571749, 6453.806385808433, 6585.20977482686, 6594.8351291218105, 6600.141981542369, 6601.174853143357, 6470.967645161744, 6484.546081774419, 6492.0261960706275, 6499.902501462388, 6502.349765023459, 6596.80209593713, 6606.900896486461, 6608.900866486911, 6614.239362473377, 6615.702293396905, 6294.464970477561, 6362.331955144643, 6460.838479038061, 6461.741530338922, 6473.449756770728], "unit": "ms", "name": "prototype.html", "value": 4944.150078929256}, {"lowerIsBetter": false, "replicates": [819.1685439279131, 893.7810236492058, 894.977625559361, 916.2212119698257, 921.5438358012776, 13819.792703109462, 14157.22135282559, 14162.362693678797, 14173.71652566948, 14204.07673501223, 12902.935485322583, 15466.767998480032, 15510.0, 15541.067535947852, 15939.84060159398, 761.603965937712, 767.6929228308666, 915.2769312243337, 917.9908200918005, 931.2224292715557, 923.8383282925495, 924.075924075924, 932.8693982842374, 932.911373419524, 933.4772527384653, 947.393668052447, 952.6141912525438, 955.9091886270793, 956.4834989105909, 957.9089986451276, 931.529577563333, 931.7251410833752, 936.7845395559026, 939.5396255834626, 939.8684184214216, 696.098552374676, 697.2817997462622, 697.5709938387855, 698.5773606967762, 698.7240040184149, 14750.409983600643, 14796.70406591873, 14800.629984250372, 14823.258837058213, 14958.252087395587, 13419.396127174301, 13449.798253026212, 13477.528286510023, 13502.257375844325, 13929.164250145024, 10295.279330446872, 11308.434578271135, 11482.253653512495, 11492.942535287353, 11615.825762613567, 3907.240177439776, 3948.4274780157, 3976.940345894814, 4000.9199816003807, 4033.193361327746, 49190.75404622954, 50259.497405025846, 52487.475125249024, 53529.1970620441, 53651.0, 10857.185711071701, 10916.126709863192, 10932.56269749217, 10947.34315941046, 11140.997310242117, 19655.508612284808, 19815.207391704458, 19850.1067451965, 19982.90008549948, 19995.200191992157, 7968.203179681986, 8309.0, 8386.748397548083, 8400.201980811813, 8447.366447516339, 4663.673542851968, 4692.95307046932, 4805.13507568641, 4805.8077676892535, 4820.39745031871, 3219.6136463624516, 3241.7406607471817, 3253.7397008239286, 3258.446064169097, 3264.8041117533025, 584.9093390524475, 600.948919341852, 605.340179204669, 614.8800983808204, 615.031325662084, 581.5405829394731, 721.6824597177225, 738.5384134915678, 738.6491416577082, 757.0990521279659, 8049.073156644654, 8750.737477875675, 8791.384603077851, 8939.106089391009, 8946.552672366355, 748.559320355663, 749.1384907356584, 753.3935182178399, 755.7279379423403, 765.3150430364792, 3711.6473934976134, 4106.609872062149, 4136.21411931732, 4186.665066794649, 4251.29853574163, 61217.38782612206, 61555.38444615586, 61857.69071154615, 61891.690541547, 61896.0, 53176.46823531792, 54000.45999539954, 54220.45779542233, 54222.0, 54246.728766356704, 45903.31145032827, 46335.536644633794, 47885.0, 47953.040939181024, 48511.5148848507, 8885.4668719877, 9002.954985225031, 9182.678606249017, 9235.26117910552, 9640.855387169058, 36802.8159859199, 37272.62727372692, 37950.43074353942, 38093.4285985716, 38164.0, 46483.0, 46488.53511464842, 46947.765261173474, 46956.295655564514, 46981.2952805715, 11757.294562326288, 11824.645260642195, 11856.940715296369, 11900.226485278428, 11996.940015299868, 13139.080264381784, 13254.072214944861, 13512.527061552799, 13537.59387218385, 13575.049746517649, 11776.941115294369, 11894.583689570823, 11899.0, 12410.441530131346, 13081.149725267827, 11099.278546894426, 11499.827502587636, 11846.99300559462, 12337.49453345531, 12350.135490515577, 10136.949315253376, 10267.94866025665, 10311.432871191857, 10473.842892356774, 11874.228175168586, 9935.354201976848, 9944.950275248866, 10030.448325342177, 10063.39619622825, 10612.575496980035, 9337.953310233677, 9929.205663547044, 10197.082262596105, 10212.336198147097, 10218.54016569271], "unit": "ms", "name": "yui.html", "value": 6789.5258934863}], "name": "dromaeo_css", "value": 7435.845678250754}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 109.0, 110.0, 100.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [146.0, 121.0, 142.0, 157.0, 127.0, 154.0, 150.0, 123.0, 171.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 161.0, 160.0, 159.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 144.0, 73.0, 71.0, 72.0, 71.0, 151.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 140.0, 93.0, 92.0, 93.0, 133.0, 93.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 144.0, 144.0, 145.0, 145.0, 145.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 60.0, 60.0, 58.0, 58.0, 57.0, 57.0, 55.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 62.0, 62.0, 64.0, 62.0, 63.0, 62.0, 62.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.6}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 78.0, 80.0, 87.0, 78.0, 78.0, 87.0, 79.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 117.0, 111.0, 117.0, 121.0, 133.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 145.0, 156.0, 146.0, 134.0, 149.0, 145.0, 146.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 65.0, 65.0, 64.0, 65.0, 63.0, 67.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1479.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.29350387075058], "unit": "score", "name": "Richards", "value": 209.76448399999992}, {"lowerIsBetter": false, "replicates": [164.41959881617888], "unit": "score", "name": "DeltaBlue", "value": 402.1296759999999}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [939.8496240601504], "unit": "score", "name": "RayTrace", "value": 787.3482960000001}, {"lowerIsBetter": false, "replicates": [547.0459518599563], "unit": "score", "name": "Earley", "value": 1218.294364}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [530.5039787798408], "unit": "score", "name": "Splay", "value": 153.61053499999994}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23260.449141140653}]} 07:47:50 INFO - RETURN: dromaeo_css: 7435.85 07:47:50 INFO - RETURN: kraken: 1479.50 07:47:50 INFO - RETURN: v8_7: 23260.45 07:47:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23260.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1479.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7435.85"}}} 07:47:51 INFO - Return code: 0 07:47:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:47:51 INFO - # TBPL SUCCESS # 07:47:51 INFO - Running post-action listener: _resource_record_post_action 07:47:51 INFO - Running post-run listener: _resource_record_post_run 07:47:52 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 86016; Write bytes: 269316096; Read time: 32; Write time: 149540 07:47:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5210112; Read time: 0; Write time: 644 07:47:52 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 86016; Write bytes: 264105984; Read time: 32; Write time: 148896 07:47:52 INFO - Running post-run listener: _upload_blobber_files 07:47:52 INFO - Blob upload gear active. 07:47:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:47:52 INFO - Copying logs to upload dir... 07:47:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.990479 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-04 07:47:52.186911) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-04 07:47:52.190655) ========= 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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010113 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454590948/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-04 07:47:52.242431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:47:52.242749) ========= 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=20e666a3d4cfbb71505a330e000001b4-1454595524.50982-690703180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 07:47:52.291863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 07:47:52.292168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 07:47:52.292456) ========= ========= Total master_lag: 0.28 =========