builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1455899355.93 results: success (0) buildid: 20160219055900 builduid: 8e8f5e730be44b849351ef9b21f35a18 revision: e0341a41fceb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:15.934469) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:15.934952) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:15.935253) ========= 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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007601 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:15.956706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:15.957030) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:15.971016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:15.971401) ========= 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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004658 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.020548) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.020881) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.021271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.021541) ========= 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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-19 08:29:16-- 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% 95.1M=0s 2016-02-19 08:29:16 (95.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.137773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.138086) ========= 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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022047 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.187553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:16.187903) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0341a41fceb --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 e0341a41fceb --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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-19 08:29:16,702 Setting DEBUG logging. 2016-02-19 08:29:16,702 attempt 1/10 2016-02-19 08:29:16,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e0341a41fceb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 08:29:17,314 unpacking tar archive at: mozilla-beta-e0341a41fceb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904979 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:17.105292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:17.105634) ========= echo e0341a41fceb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e0341a41fceb'] 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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e0341a41fceb program finished with exit code 0 elapsedTime=0.004840 script_repo_revision: 'e0341a41fceb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:17.157032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:17.157337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 08:29:17.167891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-19 08:29:17.168235) ========= /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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:17 INFO - MultiFileLogger online at 20160219 08:29:17 in /builds/slave/test-pgo 08:29:17 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 08:29:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:29:17 INFO - {'append_to_log': False, 08:29:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:29:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:29:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:29:17 INFO - 'branch': 'Mozilla-Beta', 08:29:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:17 INFO - 'config_files': ('talos/linux_config.py',), 08:29:17 INFO - 'default_actions': ('clobber', 08:29:17 INFO - 'read-buildbot-config', 08:29:17 INFO - 'download-and-extract', 08:29:17 INFO - 'populate-webroot', 08:29:17 INFO - 'create-virtualenv', 08:29:17 INFO - 'install', 08:29:17 INFO - 'run-tests'), 08:29:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:17 INFO - 'download_minidump_stackwalk': True, 08:29:17 INFO - 'download_symbols': 'ondemand', 08:29:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:17 INFO - 'installer_path': 'installer.exe', 08:29:17 INFO - 'log_level': 'info', 08:29:17 INFO - 'log_name': 'talos', 08:29:17 INFO - 'log_to_console': True, 08:29:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:17 INFO - 'opt_config_files': (), 08:29:17 INFO - 'pip_index': False, 08:29:17 INFO - 'sps_profile': False, 08:29:17 INFO - 'sps_profile_interval': 0, 08:29:17 INFO - 'suite': 'dromaeojs', 08:29:17 INFO - 'system_bits': '32', 08:29:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:17 INFO - 'title': 'talos-linux64-ix-038', 08:29:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:17 INFO - 'use_talos_json': True, 08:29:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:29:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:17 INFO - 'work_dir': 'build'} 08:29:17 INFO - ##### 08:29:17 INFO - ##### Running clobber step. 08:29:17 INFO - ##### 08:29:17 INFO - Running pre-action listener: _resource_record_pre_action 08:29:17 INFO - Running main action method: clobber 08:29:17 INFO - rmtree: /builds/slave/test-pgo/build 08:29:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:29:18 INFO - Running post-action listener: _resource_record_post_action 08:29:18 INFO - ##### 08:29:18 INFO - ##### Running read-buildbot-config step. 08:29:18 INFO - ##### 08:29:18 INFO - Running pre-action listener: _resource_record_pre_action 08:29:18 INFO - Running main action method: read_buildbot_config 08:29:18 INFO - Using buildbot properties: 08:29:18 INFO - { 08:29:18 INFO - "properties": { 08:29:18 INFO - "buildnumber": 116, 08:29:18 INFO - "product": "firefox", 08:29:18 INFO - "script_repo_revision": "production", 08:29:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:29:18 INFO - "repository": "", 08:29:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:29:18 INFO - "buildid": "20160219055900", 08:29:18 INFO - "slavename": "talos-linux64-ix-038", 08:29:18 INFO - "pgo_build": "True", 08:29:18 INFO - "basedir": "/builds/slave/test-pgo", 08:29:18 INFO - "project": "", 08:29:18 INFO - "platform": "ubuntu64_hw", 08:29:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:29:18 INFO - "slavebuilddir": "test", 08:29:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:29:18 INFO - "branch": "mozilla-beta", 08:29:18 INFO - "repo_path": "releases/mozilla-beta", 08:29:18 INFO - "stage_platform": "linux64-pgo", 08:29:18 INFO - "builduid": "8e8f5e730be44b849351ef9b21f35a18", 08:29:18 INFO - "revision": "e0341a41fceb" 08:29:18 INFO - }, 08:29:18 INFO - "sourcestamp": { 08:29:18 INFO - "repository": "", 08:29:18 INFO - "hasPatch": false, 08:29:18 INFO - "project": "", 08:29:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 08:29:18 INFO - "changes": [ 08:29:18 INFO - { 08:29:18 INFO - "category": null, 08:29:18 INFO - "files": [ 08:29:18 INFO - { 08:29:18 INFO - "url": null, 08:29:18 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.tar.bz2" 08:29:18 INFO - } 08:29:18 INFO - ], 08:29:18 INFO - "repository": "", 08:29:18 INFO - "rev": "e0341a41fceb", 08:29:18 INFO - "who": "sendchange", 08:29:18 INFO - "when": 1455899239, 08:29:18 INFO - "number": 7628028, 08:29:18 INFO - "comments": "Bug 1231818 - Make FrameLayerBuilder try harder to respect layers.max-active pref. r=mstange, a=sylvestre", 08:29:18 INFO - "project": "", 08:29:18 INFO - "at": "Fri 19 Feb 2016 08:27:19", 08:29:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 08:29:18 INFO - "revlink": "", 08:29:18 INFO - "properties": [ 08:29:18 INFO - [ 08:29:18 INFO - "buildid", 08:29:18 INFO - "20160219055900", 08:29:18 INFO - "Change" 08:29:18 INFO - ], 08:29:18 INFO - [ 08:29:18 INFO - "builduid", 08:29:18 INFO - "8e8f5e730be44b849351ef9b21f35a18", 08:29:18 INFO - "Change" 08:29:18 INFO - ], 08:29:18 INFO - [ 08:29:18 INFO - "pgo_build", 08:29:18 INFO - "True", 08:29:18 INFO - "Change" 08:29:18 INFO - ] 08:29:18 INFO - ], 08:29:18 INFO - "revision": "e0341a41fceb" 08:29:18 INFO - } 08:29:18 INFO - ], 08:29:18 INFO - "revision": "e0341a41fceb" 08:29:18 INFO - } 08:29:18 INFO - } 08:29:18 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.tar.bz2. 08:29:18 INFO - Running post-action listener: _resource_record_post_action 08:29:18 INFO - ##### 08:29:18 INFO - ##### Running download-and-extract step. 08:29:18 INFO - ##### 08:29:18 INFO - Running pre-action listener: _resource_record_pre_action 08:29:18 INFO - Running main action method: download_and_extract 08:29:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:29: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')]} 08:29:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/test_packages.json 08:29:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:29:18 INFO - Downloaded 1270 bytes. 08:29:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:29:18 INFO - Using the following test package requirements: 08:29:18 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:29:18 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:29:18 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'jsshell-linux-x86_64.zip'], 08:29:18 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:29:18 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:29:18 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 08:29:18 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 08:29:18 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:29:18 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:29:18 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:29:18 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:29: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')]} 08:29:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:29:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:19 INFO - Downloaded 22255589 bytes. 08:29:19 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 08:29:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:29:19 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 08:29:20 INFO - Return code: 0 08:29:20 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 08:29:20 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')]} 08:29:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:29:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:21 INFO - Downloaded 22255589 bytes. 08:29:21 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 08:29:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:29:21 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 08:29:22 INFO - Return code: 0 08:29: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')]} 08:29:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 08:29:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:22 INFO - Downloaded 11132038 bytes. 08:29:22 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 08:29:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 08:29:22 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 08:29:23 INFO - Return code: 0 08:29:23 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')]} 08:29:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:29:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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 08:29:23 INFO - Downloaded 58333374 bytes. 08:29:23 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:29:23 INFO - mkdir: /builds/slave/test-pgo/properties 08:29:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:29:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:29:23 INFO - Contents: 08:29:23 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:29:23 INFO - Running post-action listener: _resource_record_post_action 08:29:23 INFO - Running post-action listener: set_extra_try_arguments 08:29:23 INFO - ##### 08:29:23 INFO - ##### Running populate-webroot step. 08:29:23 INFO - ##### 08:29:23 INFO - Running pre-action listener: _resource_record_pre_action 08:29:23 INFO - Running main action method: populate_webroot 08:29:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:23 INFO - '--tppagecycles', 08:29:23 INFO - '7'], 08:29:23 INFO - 'tests': ['tsvgm']}}, 08:29:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:29:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:29:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:29:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'tests': ['damp', 'tps']}, 08:29:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['damp', 'tps']}, 08:29:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:29:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:23 INFO - 'other': {'tests': ['a11yr', 08:29:23 INFO - 'ts_paint', 08:29:23 INFO - 'tpaint', 08:29:23 INFO - 'sessionrestore', 08:29:23 INFO - 'sessionrestore_no_auto_restore']}, 08:29:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['a11yr', 08:29:23 INFO - 'ts_paint', 08:29:23 INFO - 'tpaint', 08:29:23 INFO - 'sessionrestore', 08:29:23 INFO - 'sessionrestore_no_auto_restore']}, 08:29:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['a11yr', 08:29:23 INFO - 'ts_paint', 08:29:23 INFO - 'tpaint', 08:29:23 INFO - 'sessionrestore', 08:29:23 INFO - 'sessionrestore_no_auto_restore']}, 08:29:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['a11yr', 08:29:23 INFO - 'ts_paint', 08:29:23 INFO - 'tpaint', 08:29:23 INFO - 'sessionrestore', 08:29:23 INFO - 'sessionrestore_no_auto_restore']}, 08:29:23 INFO - 'other_l64': {'tests': ['a11yr', 08:29:23 INFO - 'ts_paint', 08:29:23 INFO - 'tpaint', 08:29:23 INFO - 'sessionrestore', 08:29:23 INFO - 'sessionrestore_no_auto_restore']}, 08:29:23 INFO - 'other_nol64': {'tests': ['a11yr', 08:29:23 INFO - 'ts_paint', 08:29:23 INFO - 'tpaint', 08:29:23 INFO - 'sessionrestore', 08:29:23 INFO - 'sessionrestore_no_auto_restore']}, 08:29:23 INFO - 'svgr': {'tests': ['tsvgx', 08:29:23 INFO - 'tsvgr_opacity', 08:29:23 INFO - 'tart', 08:29:23 INFO - 'tscrollx', 08:29:23 INFO - 'cart']}, 08:29:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['tsvgx', 08:29:23 INFO - 'tsvgr_opacity', 08:29:23 INFO - 'tart', 08:29:23 INFO - 'tscrollx', 08:29:23 INFO - 'cart']}, 08:29:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'tests': ['tp5o']}, 08:29:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'talos_options': ['--e10s'], 08:29:23 INFO - 'tests': ['tp5o']}, 08:29:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'talos_options': ['--xperf_path', 08:29:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:23 INFO - 'tests': ['tp5n']}, 08:29:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:23 INFO - 'talos_options': ['--e10s', 08:29:23 INFO - '--xperf_path', 08:29:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:23 INFO - 'tests': ['tp5n']}}, 08:29:23 INFO - 'talos.zip': {'path': '', 08:29:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:23 INFO - Running post-action listener: _resource_record_post_action 08:29:23 INFO - ##### 08:29:23 INFO - ##### Running create-virtualenv step. 08:29:23 INFO - ##### 08:29:23 INFO - Running pre-action listener: _resource_record_pre_action 08:29:23 INFO - Running main action method: create_virtualenv 08:29:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:29:23 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 08:29:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:29:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:24 INFO - Using real prefix '/usr' 08:29:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:29:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:26 INFO - Installing pip.................done. 08:29:26 INFO - Return code: 0 08:29:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:29:26 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')]} 08:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:26 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')]} 08:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:26 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:26 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 08:29:26 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 08:29:26 INFO - Using env: {'DISPLAY': ':0', 08:29:26 INFO - 'HOME': '/home/cltbld', 08:29:26 INFO - 'LANG': 'en_US.UTF-8', 08:29:26 INFO - 'LANGUAGE': 'en_US:en', 08:29:26 INFO - 'LOGNAME': 'cltbld', 08:29:26 INFO - 'MAIL': '/var/mail/cltbld', 08:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:26 INFO - 'MOZ_NO_REMOTE': '1', 08:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:26 INFO - 'NO_EM_RESTART': '1', 08:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:26 INFO - 'SHELL': '/bin/bash', 08:29:26 INFO - 'SHLVL': '1', 08:29:26 INFO - 'TERM': 'linux', 08:29:26 INFO - 'TMOUT': '86400', 08:29:26 INFO - 'USER': 'cltbld', 08:29:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:26 INFO - '_': '/tools/buildbot/bin/python'} 08:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:26 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 08:29:26 INFO - Cleaning up... 08:29:26 INFO - Return code: 0 08:29:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:29:26 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')]} 08:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:26 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')]} 08:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:26 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:26 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 08:29:26 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 08:29:26 INFO - Using env: {'DISPLAY': ':0', 08:29:26 INFO - 'HOME': '/home/cltbld', 08:29:26 INFO - 'LANG': 'en_US.UTF-8', 08:29:26 INFO - 'LANGUAGE': 'en_US:en', 08:29:26 INFO - 'LOGNAME': 'cltbld', 08:29:26 INFO - 'MAIL': '/var/mail/cltbld', 08:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:26 INFO - 'MOZ_NO_REMOTE': '1', 08:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:26 INFO - 'NO_EM_RESTART': '1', 08:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:26 INFO - 'SHELL': '/bin/bash', 08:29:26 INFO - 'SHLVL': '1', 08:29:26 INFO - 'TERM': 'linux', 08:29:26 INFO - 'TMOUT': '86400', 08:29:26 INFO - 'USER': 'cltbld', 08:29:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:26 INFO - '_': '/tools/buildbot/bin/python'} 08:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:26 INFO - Downloading/unpacking psutil>=0.7.1 08:29:26 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 08:29:26 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 08:29:26 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 08:29:26 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 08:29:26 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 08:29:26 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 08:29:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:28 INFO - Installing collected packages: psutil 08:29:28 INFO - Running setup.py install for psutil 08:29:28 INFO - building 'psutil._psutil_linux' extension 08:29:28 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 08:29:29 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 08:29:29 INFO - building 'psutil._psutil_posix' extension 08:29:29 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 08:29:29 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 08:29:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:29 INFO - Successfully installed psutil 08:29:29 INFO - Cleaning up... 08:29:29 INFO - Return code: 0 08:29:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:29:29 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')]} 08:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:29 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')]} 08:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:29 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:29 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 08:29:29 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 08:29:29 INFO - Using env: {'DISPLAY': ':0', 08:29:29 INFO - 'HOME': '/home/cltbld', 08:29:29 INFO - 'LANG': 'en_US.UTF-8', 08:29:29 INFO - 'LANGUAGE': 'en_US:en', 08:29:29 INFO - 'LOGNAME': 'cltbld', 08:29:29 INFO - 'MAIL': '/var/mail/cltbld', 08:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:29 INFO - 'MOZ_NO_REMOTE': '1', 08:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:29 INFO - 'NO_EM_RESTART': '1', 08:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:29 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:29 INFO - 'SHELL': '/bin/bash', 08:29:29 INFO - 'SHLVL': '1', 08:29:29 INFO - 'TERM': 'linux', 08:29:29 INFO - 'TMOUT': '86400', 08:29:29 INFO - 'USER': 'cltbld', 08:29:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:29 INFO - '_': '/tools/buildbot/bin/python'} 08:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:29:29 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 08:29:29 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 08:29:29 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 08:29:29 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 08:29:29 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 08:29:29 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 08:29:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:29:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:29:31 INFO - Installing collected packages: mozsystemmonitor 08:29:31 INFO - Running setup.py install for mozsystemmonitor 08:29:31 INFO - Successfully installed mozsystemmonitor 08:29:31 INFO - Cleaning up... 08:29:31 INFO - Return code: 0 08:29:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:29:31 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')]} 08:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:31 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')]} 08:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:31 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:31 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 08:29:31 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 08:29:31 INFO - Using env: {'DISPLAY': ':0', 08:29:31 INFO - 'HOME': '/home/cltbld', 08:29:31 INFO - 'LANG': 'en_US.UTF-8', 08:29:31 INFO - 'LANGUAGE': 'en_US:en', 08:29:31 INFO - 'LOGNAME': 'cltbld', 08:29:31 INFO - 'MAIL': '/var/mail/cltbld', 08:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:31 INFO - 'MOZ_NO_REMOTE': '1', 08:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:31 INFO - 'NO_EM_RESTART': '1', 08:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:31 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:31 INFO - 'SHELL': '/bin/bash', 08:29:31 INFO - 'SHLVL': '1', 08:29:31 INFO - 'TERM': 'linux', 08:29:31 INFO - 'TMOUT': '86400', 08:29:31 INFO - 'USER': 'cltbld', 08:29:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:31 INFO - '_': '/tools/buildbot/bin/python'} 08:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:31 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 08:29:31 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 08:29:31 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 08:29:31 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 08:29:31 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 08:29:31 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 08:29:33 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29:33 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 08:29:33 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 08:29:33 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 08:29:33 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 08:29:33 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 08:29:33 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 08:29:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:29:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:34 INFO - Downloading docopt-0.6.1.tar.gz 08:29:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:34 INFO - Running setup.py install for blobuploader 08:29:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:29:34 INFO - Running setup.py install for requests 08:29:34 INFO - Running setup.py install for docopt 08:29:34 INFO - Successfully installed blobuploader requests docopt 08:29:34 INFO - Cleaning up... 08:29:34 INFO - Return code: 0 08:29:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:34 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 08:29:34 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 08:29:34 INFO - Using env: {'DISPLAY': ':0', 08:29:34 INFO - 'HOME': '/home/cltbld', 08:29:34 INFO - 'LANG': 'en_US.UTF-8', 08:29:34 INFO - 'LANGUAGE': 'en_US:en', 08:29:34 INFO - 'LOGNAME': 'cltbld', 08:29:34 INFO - 'MAIL': '/var/mail/cltbld', 08:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:34 INFO - 'MOZ_NO_REMOTE': '1', 08:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:34 INFO - 'NO_EM_RESTART': '1', 08:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:34 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:34 INFO - 'SHELL': '/bin/bash', 08:29:34 INFO - 'SHLVL': '1', 08:29:34 INFO - 'TERM': 'linux', 08:29:34 INFO - 'TMOUT': '86400', 08:29:34 INFO - 'USER': 'cltbld', 08:29:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:34 INFO - '_': '/tools/buildbot/bin/python'} 08:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:29:35 INFO - Running setup.py (path:/tmp/pip-mEAx_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:29:35 INFO - Running setup.py (path:/tmp/pip-OYjwWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:29:35 INFO - Running setup.py (path:/tmp/pip-NFNjlq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:29:35 INFO - Running setup.py (path:/tmp/pip-JZi3HP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:29:35 INFO - Running setup.py (path:/tmp/pip-Q8UFBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:29:35 INFO - Running setup.py (path:/tmp/pip-XhOTcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:29:35 INFO - Running setup.py (path:/tmp/pip-qvI0IZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:29:35 INFO - Running setup.py (path:/tmp/pip-qZYAiZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:29:35 INFO - Running setup.py (path:/tmp/pip-q9LIAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:29:35 INFO - Running setup.py (path:/tmp/pip-xCdnmq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:29:35 INFO - Running setup.py (path:/tmp/pip-yRbJeQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:29:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:29:35 INFO - Running setup.py (path:/tmp/pip-k0fh8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:29:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:29:36 INFO - Running setup.py (path:/tmp/pip-_Hdysy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:29:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:29:36 INFO - Running setup.py (path:/tmp/pip-MQZGdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:29:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:29:36 INFO - Running setup.py (path:/tmp/pip-ukY8tv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:29:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:29:36 INFO - Running setup.py (path:/tmp/pip-7olu2J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:29:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:29:36 INFO - Running setup.py (path:/tmp/pip-xUcEQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:29:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:36 INFO - Running setup.py install for manifestparser 08:29:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:29:36 INFO - Running setup.py install for mozcrash 08:29:36 INFO - Running setup.py install for mozdebug 08:29:36 INFO - Running setup.py install for mozdevice 08:29:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:29:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:29:36 INFO - Running setup.py install for mozfile 08:29:36 INFO - Running setup.py install for mozhttpd 08:29:36 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Running setup.py install for mozinfo 08:29:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Running setup.py install for mozInstall 08:29:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Running setup.py install for mozleak 08:29:37 INFO - Running setup.py install for mozlog 08:29:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Running setup.py install for moznetwork 08:29:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Running setup.py install for mozprocess 08:29:37 INFO - Running setup.py install for mozprofile 08:29:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Running setup.py install for mozrunner 08:29:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:29:37 INFO - Running setup.py install for mozscreenshot 08:29:37 INFO - Running setup.py install for moztest 08:29:38 INFO - Running setup.py install for mozversion 08:29:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:29:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:38 INFO - Cleaning up... 08:29:38 INFO - Return code: 0 08:29:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:38 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:38 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 08:29:38 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 08:29:38 INFO - Using env: {'DISPLAY': ':0', 08:29:38 INFO - 'HOME': '/home/cltbld', 08:29:38 INFO - 'LANG': 'en_US.UTF-8', 08:29:38 INFO - 'LANGUAGE': 'en_US:en', 08:29:38 INFO - 'LOGNAME': 'cltbld', 08:29:38 INFO - 'MAIL': '/var/mail/cltbld', 08:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:38 INFO - 'MOZ_NO_REMOTE': '1', 08:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:38 INFO - 'NO_EM_RESTART': '1', 08:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:38 INFO - 'SHELL': '/bin/bash', 08:29:38 INFO - 'SHLVL': '1', 08:29:38 INFO - 'TERM': 'linux', 08:29:38 INFO - 'TMOUT': '86400', 08:29:38 INFO - 'USER': 'cltbld', 08:29:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:38 INFO - '_': '/tools/buildbot/bin/python'} 08:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:29:38 INFO - Running setup.py (path:/tmp/pip-5kk84g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:29:38 INFO - Running setup.py (path:/tmp/pip-q9l_lP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:29:38 INFO - Running setup.py (path:/tmp/pip-H5NR3k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:29:38 INFO - Running setup.py (path:/tmp/pip-BhiXO0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:29:38 INFO - Running setup.py (path:/tmp/pip-swheUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:29:38 INFO - Running setup.py (path:/tmp/pip-H2WuCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:29:38 INFO - Running setup.py (path:/tmp/pip-ZMGxI4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:29:38 INFO - Running setup.py (path:/tmp/pip-eQTeRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:29:38 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)) 08:29:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:29:38 INFO - Running setup.py (path:/tmp/pip-H1tTYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:29:39 INFO - Running setup.py (path:/tmp/pip-dUBhi6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:29:39 INFO - Running setup.py (path:/tmp/pip-hpk6kK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:29:39 INFO - Running setup.py (path:/tmp/pip-IVtYSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:29:39 INFO - Running setup.py (path:/tmp/pip-DBtl6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:29:39 INFO - Running setup.py (path:/tmp/pip-z7PM6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:29:39 INFO - Running setup.py (path:/tmp/pip-hC95PV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:29:39 INFO - Running setup.py (path:/tmp/pip-Ox2Cer-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:29:39 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)) 08:29:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:29:39 INFO - Running setup.py (path:/tmp/pip-XSVDvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:29:39 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)) 08:29:39 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)) 08:29:39 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)) 08:29:39 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)) 08:29:39 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)) 08:29:39 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)) 08:29:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:41 INFO - Downloading blessings-1.6.tar.gz 08:29:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:41 INFO - Installing collected packages: blessings 08:29:41 INFO - Running setup.py install for blessings 08:29:41 INFO - Successfully installed blessings 08:29:41 INFO - Cleaning up... 08:29:41 INFO - Return code: 0 08:29:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:29:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:29:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:29:42 INFO - Reading from file tmpfile_stdout 08:29:42 INFO - Current package versions: 08:29:42 INFO - argparse == 1.2.1 08:29:42 INFO - blessings == 1.6 08:29:42 INFO - blobuploader == 1.2.4 08:29:42 INFO - docopt == 0.6.1 08:29:42 INFO - manifestparser == 1.1 08:29:42 INFO - mozInstall == 1.12 08:29:42 INFO - mozcrash == 0.16 08:29:42 INFO - mozdebug == 0.1 08:29:42 INFO - mozdevice == 0.47 08:29:42 INFO - mozfile == 1.2 08:29:42 INFO - mozhttpd == 0.7 08:29:42 INFO - mozinfo == 0.9 08:29:42 INFO - mozleak == 0.1 08:29:42 INFO - mozlog == 3.1 08:29:42 INFO - moznetwork == 0.27 08:29:42 INFO - mozprocess == 0.22 08:29:42 INFO - mozprofile == 0.27 08:29:42 INFO - mozrunner == 6.11 08:29:42 INFO - mozscreenshot == 0.1 08:29:42 INFO - mozsystemmonitor == 0.0 08:29:42 INFO - moztest == 0.7 08:29:42 INFO - mozversion == 1.4 08:29:42 INFO - psutil == 3.1.1 08:29:42 INFO - requests == 1.2.3 08:29:42 INFO - wsgiref == 0.1.2 08:29:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:29: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')]} 08:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:42 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:42 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 08:29:42 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 08:29:42 INFO - Using env: {'DISPLAY': ':0', 08:29:42 INFO - 'HOME': '/home/cltbld', 08:29:42 INFO - 'LANG': 'en_US.UTF-8', 08:29:42 INFO - 'LANGUAGE': 'en_US:en', 08:29:42 INFO - 'LOGNAME': 'cltbld', 08:29:42 INFO - 'MAIL': '/var/mail/cltbld', 08:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:42 INFO - 'MOZ_NO_REMOTE': '1', 08:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:42 INFO - 'NO_EM_RESTART': '1', 08:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:42 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:42 INFO - 'SHELL': '/bin/bash', 08:29:42 INFO - 'SHLVL': '1', 08:29:42 INFO - 'TERM': 'linux', 08:29:42 INFO - 'TMOUT': '86400', 08:29:42 INFO - 'USER': 'cltbld', 08:29:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:42 INFO - '_': '/tools/buildbot/bin/python'} 08:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 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)) 08:29:42 INFO - Cleaning up... 08:29:42 INFO - Return code: 0 08:29:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:29: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')]} 08:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:42 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:42 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 08:29:42 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 08:29:42 INFO - Using env: {'DISPLAY': ':0', 08:29:42 INFO - 'HOME': '/home/cltbld', 08:29:42 INFO - 'LANG': 'en_US.UTF-8', 08:29:42 INFO - 'LANGUAGE': 'en_US:en', 08:29:42 INFO - 'LOGNAME': 'cltbld', 08:29:42 INFO - 'MAIL': '/var/mail/cltbld', 08:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:42 INFO - 'MOZ_NO_REMOTE': '1', 08:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:42 INFO - 'NO_EM_RESTART': '1', 08:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:42 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:42 INFO - 'SHELL': '/bin/bash', 08:29:42 INFO - 'SHLVL': '1', 08:29:42 INFO - 'TERM': 'linux', 08:29:42 INFO - 'TMOUT': '86400', 08:29:42 INFO - 'USER': 'cltbld', 08:29:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:42 INFO - '_': '/tools/buildbot/bin/python'} 08:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:42 INFO - Downloading/unpacking jsonschema 08:29:42 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 08:29:42 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 08:29:42 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 08:29:42 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 08:29:42 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 08:29:42 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 08:29:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:29:44 INFO - Downloading/unpacking functools32 (from jsonschema) 08:29:44 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 08:29:44 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 08:29:44 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 08:29:44 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 08:29:44 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 08:29:44 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 08:29:44 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:44 INFO - warning: no files found matching '*.txt' 08:29:44 INFO - no previously-included directories found matching 'build' 08:29:44 INFO - no previously-included directories found matching 'dist' 08:29:44 INFO - no previously-included directories found matching '.git*' 08:29:44 INFO - Installing collected packages: jsonschema, functools32 08:29:44 INFO - Running setup.py install for functools32 08:29:44 INFO - warning: no files found matching '*.txt' 08:29:44 INFO - no previously-included directories found matching 'build' 08:29:44 INFO - no previously-included directories found matching 'dist' 08:29:44 INFO - no previously-included directories found matching '.git*' 08:29:44 INFO - Successfully installed jsonschema functools32 08:29:44 INFO - Cleaning up... 08:29:44 INFO - Return code: 0 08:29:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:44 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 0x7fbaf3914f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1394600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, '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': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', '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 08:29:44 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 08:29:44 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 08:29:44 INFO - Using env: {'DISPLAY': ':0', 08:29:44 INFO - 'HOME': '/home/cltbld', 08:29:44 INFO - 'LANG': 'en_US.UTF-8', 08:29:44 INFO - 'LANGUAGE': 'en_US:en', 08:29:44 INFO - 'LOGNAME': 'cltbld', 08:29:44 INFO - 'MAIL': '/var/mail/cltbld', 08:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:44 INFO - 'MOZ_NO_REMOTE': '1', 08:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:44 INFO - 'NO_EM_RESTART': '1', 08:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:29:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:29:44 INFO - 'SHELL': '/bin/bash', 08:29:44 INFO - 'SHLVL': '1', 08:29:44 INFO - 'TERM': 'linux', 08:29:44 INFO - 'TMOUT': '86400', 08:29:44 INFO - 'USER': 'cltbld', 08:29:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:44 INFO - '_': '/tools/buildbot/bin/python'} 08:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:45 INFO - Downloading/unpacking flake8 08:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:29:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:29:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:29:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:29:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:29:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:29:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:29:47 INFO - no previously-included directories found matching 'docs/_build' 08:29:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:29:47 INFO - Running setup.py install for pep8 08:29:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:29:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:29:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:29:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:29:47 INFO - no previously-included directories found matching 'docs/_build' 08:29:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:29:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:29:47 INFO - Cleaning up... 08:29:47 INFO - Return code: 0 08:29:47 INFO - Running post-action listener: _resource_record_post_action 08:29:47 INFO - Running post-action listener: _start_resource_monitoring 08:29:47 INFO - Starting resource monitoring. 08:29:47 INFO - ##### 08:29:47 INFO - ##### Running install step. 08:29:47 INFO - ##### 08:29:47 INFO - Running pre-action listener: _resource_record_pre_action 08:29:47 INFO - Running main action method: install 08:29:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:29:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:29:47 INFO - Reading from file tmpfile_stdout 08:29:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:29:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:29:48 INFO - Reading from file tmpfile_stdout 08:29:48 INFO - Output received: 08:29:48 INFO - Usage: mozinstall [options] installer 08:29:48 INFO - Options: 08:29:48 INFO - -h, --help show this help message and exit 08:29:48 INFO - -d DEST, --destination=DEST 08:29:48 INFO - Directory to install application into. [default: 08:29:48 INFO - "/builds/slave/test-pgo"] 08:29:48 INFO - --app=APP Application being installed. [default: firefox] 08:29:48 INFO - mkdir: /builds/slave/test-pgo/build/application 08:29:48 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'] 08:29:48 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 08:30:09 INFO - Reading from file tmpfile_stdout 08:30:09 INFO - Output received: 08:30:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:30:10 INFO - Running post-action listener: _resource_record_post_action 08:30:10 INFO - ##### 08:30:10 INFO - ##### Running run-tests step. 08:30:10 INFO - ##### 08:30:10 INFO - Running pre-action listener: _resource_record_pre_action 08:30:10 INFO - Running main action method: run_tests 08:30:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:30:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:30:10 INFO - Python 2.7.3 08:30:10 INFO - Return code: 0 08:30:10 INFO - grabbing minidump binary from tooltool 08:30:10 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')]} 08:30:10 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 0x1423350>, '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 0x1424250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14246e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:30:10 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 08:30:10 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 08:30:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:10 INFO - Return code: 0 08:30:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:30:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:30:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:30:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:30:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:30:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:30:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:30:11 INFO - Return code: 0 08:30:11 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/1455890340/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:30:11 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/1455890340/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost 08:30:11 INFO - Using env: {'DISPLAY': ':0', 08:30:11 INFO - 'HOME': '/home/cltbld', 08:30:11 INFO - 'LANG': 'en_US.UTF-8', 08:30:11 INFO - 'LANGUAGE': 'en_US:en', 08:30:11 INFO - 'LOGNAME': 'cltbld', 08:30:11 INFO - 'MAIL': '/var/mail/cltbld', 08:30:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:30:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:11 INFO - 'MOZ_NO_REMOTE': '1', 08:30:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:11 INFO - 'NO_EM_RESTART': '1', 08:30:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:30:11 INFO - 'PWD': '/builds/slave/test-pgo', 08:30:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:30:11 INFO - 'SHELL': '/bin/bash', 08:30:11 INFO - 'SHLVL': '1', 08:30:11 INFO - 'TERM': 'linux', 08:30:11 INFO - 'TMOUT': '86400', 08:30:11 INFO - 'USER': 'cltbld', 08:30:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529', 08:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:11 INFO - '_': '/tools/buildbot/bin/python'} 08:30:11 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/1455890340/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] with output_timeout 3600 08:30:12 INFO - mozversion INFO | application_buildid: 20160219055900 08:30:12 INFO - mozversion INFO | application_changeset: e0341a41fceba62feb0a3b205e525e73a7bddab5 08:30:12 INFO - mozversion INFO | application_display_name: Nightly 08:30:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:12 INFO - mozversion INFO | application_name: Firefox 08:30:12 INFO - mozversion INFO | application_remotingname: firefox 08:30:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:30:12 INFO - mozversion INFO | application_vendor: Mozilla 08:30:12 INFO - mozversion INFO | application_version: 45.0 08:30:12 INFO - mozversion INFO | platform_buildid: 20160219055900 08:30:12 INFO - mozversion INFO | platform_changeset: e0341a41fceba62feb0a3b205e525e73a7bddab5 08:30:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:30:12 INFO - mozversion INFO | platform_version: 45.0 08:30:12 INFO - 2016-02-19 08:30:12,023 DEBUG : using testdate: 1455899412 08:30:12 INFO - 2016-02-19 08:30:12,024 DEBUG : actual date: 1455899412 08:30:12 INFO - 2016-02-19 08:30:12,032 INFO : starting webserver on 'localhost:54510' 08:30:12 INFO - 2016-02-19 08:30:12,033 INFO : Starting test suite talos-linux64-ix-038 08:30:12 INFO - 2016-02-19 08:30:12,033 INFO : Starting test dromaeo_css 08:30:12 INFO - 2016-02-19 08:30:12,033 DEBUG : operating with platform_type : linux_ 08:30:12 INFO - 2016-02-19 08:30:12,034 INFO : Initialising browser for dromaeo_css test... 08:30:12 INFO - 2016-02-19 08:30:12,047 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwbG2Au/profile http://localhost:54510/getInfo.html 08:30:16 INFO - 2016-02-19 08:30:16,632 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:30:16 INFO - 2016-02-19 08:30:16,633 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:30:16 INFO - 2016-02-19 08:30:16,633 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:30:16 INFO - 2016-02-19 08:30:16,633 DEBUG : BROWSER_OUTPUT: __metrics 08:30:16 INFO - 2016-02-19 08:30:16,871 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] 08:30:18 INFO - 2016-02-19 08:30:18,237 INFO : Browser initialized. 08:30:18 INFO - 2016-02-19 08:30:18,238 INFO : Running cycle 1/1 for dromaeo_css test... 08:30:18 INFO - 2016-02-19 08:30:18,238 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwbG2Au/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:30:29 INFO - 2016-02-19 08:30:29,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 133115904 08:30:29 INFO - 2016-02-19 08:30:29,860 DEBUG : BROWSER_OUTPUT: 08:31:20 INFO - 2016-02-19 08:31:20,759 DEBUG : BROWSER_OUTPUT: 1455899480753 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] 08:33:29 INFO - 2016-02-19 08:33:29,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54510/tests/dromaeo/cssquery-ext.html) 08:33:30 INFO - 2016-02-19 08:33:30,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 206942208 08:33:30 INFO - 2016-02-19 08:33:30,307 DEBUG : BROWSER_OUTPUT: 08:36:32 INFO - 2016-02-19 08:36:32,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/dromaeo/cssquery-ext.html (next: http://localhost:54510/tests/dromaeo/cssquery-jquery.html) 08:36:32 INFO - 2016-02-19 08:36:32,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 203018240 08:36:32 INFO - 2016-02-19 08:36:32,960 DEBUG : BROWSER_OUTPUT: 08:39:34 INFO - 2016-02-19 08:39:34,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54510/tests/dromaeo/cssquery-mootools.html) 08:39:35 INFO - 2016-02-19 08:39:35,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 209563648 08:39:35 INFO - 2016-02-19 08:39:35,326 DEBUG : BROWSER_OUTPUT: 08:42:37 INFO - 2016-02-19 08:42:37,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54510/tests/dromaeo/cssquery-prototype.html) 08:42:37 INFO - 2016-02-19 08:42:37,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 201437184 08:42:37 INFO - 2016-02-19 08:42:37,598 DEBUG : BROWSER_OUTPUT: 08:45:39 INFO - 2016-02-19 08:45:39,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54510/tests/dromaeo/cssquery-yui.html) 08:45:40 INFO - 2016-02-19 08:45:40,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 199335936 08:45:40 INFO - 2016-02-19 08:45:40,481 DEBUG : BROWSER_OUTPUT: 08:48:42 INFO - 2016-02-19 08:48:42,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/dromaeo/cssquery-yui.html (next: http://localhost:54510/tests/dromaeo/cssquery-dojo.html) 08:48:43 INFO - 2016-02-19 08:48:43,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 240041984 08:48:43 INFO - 2016-02-19 08:48:43,001 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,002 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:48:43 INFO - 2016-02-19 08:48:43,002 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:48:43 INFO - 2016-02-19 08:48:43,002 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:48:43 INFO - 2016-02-19 08:48:43,002 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:48:43 INFO - 2016-02-19 08:48:43,004 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3285.622153452353;3359.815210163443;3395.2530443302467;3397.6092749333834;3419.5896492420907;5551.2228288039705;5578.888422231553;5594.636348637341;5597.832065038046;5603.551715862732;5520.806771762989;5575.749091290892;5600.355959064709;5600.52395546378;5614.550835933126;4850.951490485103;5064.417591976915;5084.618653600976;5122.795088196468;5184.559312458427;5007.123753343169;5033.874153146182;5064.3163172971545;5072.72100034498;5073.949260507385;4891.755412229392;4947.8268260610885;4977.776000080005;4984.601231901439;4993.650444468889;5021.39743230811;5101.107306221415;5128.205128205134;5151.072806894757;5168.9224661630105;5017.84946451607;5084.135696931494;5104.846854594368;5121.795128194905;5130.53825155734;5257.342832145981;5284.286621306152;5354.732263386854;5372.7313634318125;5387.353517577876;5946.108083787423;5948.018576934801;5955.970220148914;5958.314793798725;6036.215292012054;5933.139694744281;5978.910316345258;5983.491403230731;5986.2217911671205;5991.191189189447;5383.057964856134;5486.780528778844;5546.112621980464;5588.720563971826;5732;5996.850078747979;6033.487153591994;6039.667818270037;6040.275166979903;6042.939570604326;5894.941050589525;5898.616589921641;5899.587028908021;5902.321233058167;5907.61600495975;5627.690477023803;5740.052891272977;5950.821475355746;6062.363451837494;6082.878342433127;5992;5998.49012833914;6001.879962400728;6008.669523176267;6013.6993150342305;5799.942000580025;5997.730102145414;6000.0699891516015;6005.849853753603;6010.909836352458;4484.686071974996;4485.259932111165;4553.840615578439;4568.771561421916;4573.771311434415;4102.774347410921;4112.198121366305;4128.772917489567;4132.380142978577;4152.875413737593;5665.745041473144;5706.457886500776;5725.942740572625;5727.284089488814;5756;5762.337331206881;5873.295204575478;5929.644221346733;6029.397060293935;6062.454379105901;5619.494245517842;5653.717314134276;5657.915131273035;5670.943290567042;5674.77300907959;4996.375453068366;5178.171492561172;5181.145111056633;5196.610254230872;5231.189165679326;5927.911081333784;6100.603460775035;6162.322144564095;6174.475169610633;6180.227471566144;6006.189164462741;6032.819015429544;6053.878922421615;6084.787032453843;6091.299500557493;5859.091840764689;5967.433093856077;6234.770606086284;6251.718672659832;6267.2792628848265;5800.24596802413;5861.648301101947;5869.618474799125;5877.324107727495;5909.054551271776;5894.410558944242;5939.881202375842;5948.583599148018;5952.642841429528;5954.880902381841;5630.127330263816;5734.5125664319;5786.94213057864;5820.330661973927;5822.912656310244;5837.766489340379;5867.73595188209;5879.647221166743;5880.8235752927485;5886.852828679146;5749.741261643152;5753.683547404933;5754.251947246831;5755.165501002248;5790.24726785532;5630.211770352236;5708.600397972268;5775.104858746901;5791.333996590446;5872.882542349214;5727.6849773262875;5737.770489180553;5784.913226301693;5785;5797.739101740347 08:48:43 INFO - 2016-02-19 08:48:43,004 DEBUG : BROWSER_OUTPUT: |1;ext.html;592.2685483427965;623.9937600623992;636.4272155060445;638.0238235499684;642.1267076775584;32149.19627009326;42954.140917181634;43777.56222437775;43794;43963.34054989178;46315.30527042097;46832;46908.765456172754;46910;46929.7653511732;7791.883121753178;7898.526088434713;9092.363534552584;9284.396514226553;10541.420221887793;10672.252942294042;10684.358938463678;10787.029167374934;10814.29707069038;10816.567337306498;10719.410432426213;10797.83803242952;10853.24027318088;10856.34861908288;10857;8011.198880111971;8181.059178194524;10902.182336324808;11009.504572294267;11075.16936229778;10662.893371066268;10783.13734901206;10790.67627971162;10799.514021869034;10803.83794243087;44487;44620.10759784819;44935.32597011015;44997;45088.77455612734;3532.4701294805727;3663.3222853772136;3695.6858667013335;3787.7537960032787;3820.2168555446065;33189.6681033189;33512.497312540334;33542.49686254708;33606.83196584026;33741.6625833741;4208.915821683579;4291.635211007068;4322.654187665011;4352;4377.409049778271;306266;307952;309281;310009;310283.4485827579;57137;58139;63670.363296367366;64295.67852160709;73138.44015459434;64904;65160.34839651543;65306;65585.67207163933;65688;14494.710105798036;14558.781618275734;14625.926870365793;14627.195504247156;14657.853421465648;11006.614768483065;11032.558697652004;11039.39283339408;11042.171837112248;11049.889501105046;21343.46641333948;21705.891470542545;21717.34847954564;21734;21740;8367.205115514016;8478.279346255515;8588.742337729878;8657.177568131017;8712;1100.2683215661496;1103.172620534599;1128.2440764687678;1133.4616057372682;1237.8576463706788;29610;29990.250243743645;30600.54099188514;30743.077707668806;31174;1200.5737963023;1234.5185377702703;1245.5017992802952;1256.4094875408543;1298.104308027458;13330.666733331744;15351.462698805488;15788.289526971314;16082.919585402233;16224.026558406533;356616;358123;358876;358923;359308;56887;57158.428415716146;57302.42697572971;57375;57478.137827932616;1286.4789760147155;1359.6736783171968;1439.6113049476583;1459.4745891479272;1473.977890331646;26965.730342696323;27227.72772272252;27570.310742231606;27958.860205699653;28389.716102839535;41476;41830.79084604557;41874.58125418707;41875.37186942259;41888.58111418847;196094;197852;197854;198184;198559;33965;34198;34443.655563444045;34485.827570861984;34512.65487345094;43662.56337436585;43672.344914826936;44209.33685994777;44495.55504444914;44753.10493790171;36342.27315453729;36723.816380917924;37677.62322376741;37916.43125353177;38055;36595.45106823453;36719.66593994315;36859.44710829286;37300.253994920495;37709.622903771706;37076.81461592675;37137.628623714496;37296.81351593225;38298.23403531969;38999.80500097481;29730.405391892473;29900.551491728078;30078.699213008465;30219.244518886324;30449.39101217919;25176.622350665122;25772.8711356442;25850;26454.338641534116;27887.442251154458 08:48:43 INFO - 2016-02-19 08:48:43,005 DEBUG : BROWSER_OUTPUT: |2;jquery.html;382.8966179131634;386.7602086706242;397.276955940189;397.36024999750396;398.3486998757031;14505.492307769231;17351.913240433794;17481.82518174818;18744.343947961806;18755.4373368799;17416.56458588536;17752;17758.55603609907;18819.717704234412;19176.137073831676;5068.1384164692;5186.92219616706;5189.8183563575285;5189.999999999981;5191.714455704935;3856.84572617095;3958.5447673517624;3963.1479231965122;3964.0684439156776;5149.639525233235;5415.214793854889;5595.692236926988;5603.2435621191025;5607.074832652607;5610.214569960209;5409.188621706736;5543.972280138614;5546.750396232159;5557.166425036236;5557.972210138963;5325.227841962894;5342.385625653061;5360;5675.886482270373;5685.715714214272;16597.004179749132;20015.599688006158;20457.79542204574;20933.162673493043;21402.678959815614;2219.933401997943;2228.832837537191;2252.2342403582697;2358.716953965535;2464.4824586836785;10584.735381615445;11077.723056923562;13907.443702251898;14214.786778198335;14354.282285885769;1925.431997560723;2012.537116463207;2031.1063132221775;2032.3699653107583;2046.4372297618124;65488.67255663691;68612.3138768611;69006.65496672534;69290.3070969289;69759.65120174366;11155.944220278847;11299.54801807935;11342.60300889465;11358.375289359165;11381.715457113638;14911.776323355158;15026.647601715898;15063.774043389358;15064.623384415258;15092.245387730569;7963.641636126388;8002.7199048033035;8013.959930200312;8054.355651547862;8078.555679437687;7492.325690687755;7496.550206987598;7520.586367749826;7521.398288136936;7563.319301262913;4711.552402521755;4724.929126063112;4739.431268247763;4788.473267940523;4866.9513304867205;1686.110640712887;1924.7401600783714;1945.834604058671;2002;2018.6063717574932;978.3591747405461;1010.9797804044025;1073.0235485707967;1078.185969592968;1098.9780204395868;17151.313947442213;17577.912110439367;17651.55871103207;18004.189811458516;18117.909410452863;943.6697155995347;944.3200895355333;964.4984608003939;1000.7698229407132;1069.0165048155716;9962.800743985079;10039.598416063276;10047.24645651579;10112.393256404639;10232.59069637221;566428;592907;602897;656328;656794;81792.59103704443;82124.58937705393;82878.58560707158;83586;84186.15813841783;1203.175824560179;1248.0577164241122;1250.287336218365;1251.2429979862052;1254.1534464236786;15229.400912903986;15457.227138643248;15503.302351393988;15596.84403155954;15699.293531790869;33826.66173338235;34038.65961340454;34278.82860585681;34325.141871453416;34672.82663586666;40835;42383.3642495369;42851.78574107109;43268.35097473478;46946.06107877755;9445.574949127444;9806.950965245414;9816.852747208655;9831.410115393099;9834.114929656365;11464.484098215433;11551.133664975328;14160.78758818598;17012.31950722007;17626;14762.48331308399;14865.331060102106;15383.38466461329;15711.450099246471;15783.131927744083;14560.490382836973;15073.773893391388;15716.292766825292;15765.605859853136;15832.762508562151;15843.524694259191;15967.760483592523;16176.67646647037;16379.09914954689;16625.085620291;10127.89872101299;10252.128569071712;10377.533011014371;10418.531166097695;10585.623868896993;15145.318460669076;15560.688786224438;15677.05937643745;15919.522414327588;16145.75781363257 08:48:43 INFO - 2016-02-19 08:48:43,006 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1583.7386831172857;1592.6894255620143;1634.7466142747871;1816.745655608215;1938.7576552930875;7440.330370266675;7587.393008559316;8340.83318333633;8622.310215182779;8628.050914399411;8045.597720114;8237.50574965501;8335.624896879639;8335.791605209874;8344.332453403727;2283.189467738958;2320.141547627372;2321.58211521926;2323.233333000106;2323.9535209295805;2012.2051789543123;2050.425880753384;2249.3364457485;2306.3657494189065;2333.603287441139;2278.1798552521077;2294.27730264966;2296.437372843656;2300.148944890393;2306.3888069661552;2279.327598358488;2309.0532881518498;2310.387747246981;2311.5376924614975;2311.8150547956125;2309.953800923989;2333.4166458385403;2334.661474086265;2336.0422226886894;2337.789598936104;8373.706920257762;8460.069392366835;8460.8730869037;8466.026406963216;8474.661013559451;4779.976100119512;4884.145274576935;4905;4917.311576379309;4923.950760492385;3096.8451577421265;3126.8749250029973;3146.6224053113774;3166.857491412892;3167.224030112637;1002.7543251903257;1003.8494225866178;1007.8286691262502;1031.9484025798756;1046.6284469013467;11501.539938402453;11523;11523.250988685708;11526;11534.769304613945;4273.508546517128;4310.762908040025;4327.632151267115;4372.606465418127;4387.912241755147;9856.852147217798;9858.852117218248;9871.358361706467;9875.111239988435;9875.506224688737;4793.065352256346;4798.2082956311815;4800.7599620019555;4808.206645903457;4812.326274321597;4354.216241076637;4357.782110894443;4358.411614432074;4362.563743625612;4363.869083927487;3717.75834570752;3777.150141218259;3812.0660438192267;3827.8086095695103;3837.059920319484;1058.380847204394;1123.966281011571;1168.5033860609208;1184.2006645514243;1187.821826725998;1165.9008984236266;1189.1102534682445;1196.9945245993408;1484.502691598305;1504.9623759406102;8103.594820258963;8145.918540814635;8205.71280005197;8207.71273005442;8216.835663286702;1180.8582970043649;1197.275648232824;1201.6094769200045;1222.6515443098674;1231.2673958994385;6405.551611387158;6451.838704032437;6521.543491955517;6522.771702990467;6524.380183882524;10010.199184065257;10314.948425257826;10315.793684126276;10323.896761032294;10329.84505232422;9550.665726699532;10185;10191.133753631024;10197.643082492077;10202.795944081077;8072.677092916218;8154.918450815535;8167.183281671785;8172.060213075572;8182.263596276363;8123.837523249384;8128.105908349959;8225.588720564068;8231.629576668944;8236.34109271245;9208.309376796633;9321.766955826159;9394.436333819993;9431.056894310514;9455.621775129193;9345.48599827016;9424.246060315296;9636.75908102303;9660.227181825578;9692.321537492307;7161.57030578167;7244.058272424551;7258.637068146677;7261.5280006799385;7265.4550908681;6954.582725036514;7854.6858125674335;7938.166492518202;7947.642356094106;7950.40371972116;6549.672516374067;6554.476526537413;6740.561863478858;7583.127940286938;7587.962060189664;7269.854602907806;7430.44271679637;7526.09686837583;7529.13414957265;7542.47202695806;7359.521631093961;7362.6686799093095;7460.477766556506;7480.102387713509;7485;7049.859002820018;7095.46783991213;7102.218755936946;7103.609301488468;7111.075560177143;7046.577205367695;7118.750843720445;7182.712691492491;7213.134423868959;7214.783556493314 08:48:43 INFO - 2016-02-19 08:48:43,007 DEBUG : BROWSER_OUTPUT: |4;prototype.html;359.29578027066947;364.7793085183464;376.4752751357004;377.83752986215916;384.8287512057134;6051.667158306292;6082.330943596206;6098.695065246742;6101.633901965874;6191.3499082596245;6033.849153771147;6035.758569657209;6047.15339852421;6051.78818741343;6052.818415447533;4645.721256724591;4689.155951928651;4709.552592503724;4711.835085771999;4720.929186062194;4710.458297295821;4717.740524271164;4717.740524271164;4723.055388922229;4724.078804633098;4435.711678740888;4533.2066888294585;4681.74250416227;4691.0617876424685;4702.05958808238;4580.725156490605;4640.628749700016;4673.836415725467;4676.0647870426055;4697.295405689174;4145.336746120606;4153.875383738462;4157.043879907638;4169.812358443877;4170.145120250371;5503.504684578367;5621.353544342412;5625.493705566519;5693.5445164387165;5765.106408506646;5490.835274941758;5490.890182196374;5493.176023596453;5499.697516636584;5515.669059856381;6436.967815160894;6447.387498187664;6448.967755161241;6455.354464553554;6456.289808121103;4560.315952607102;4622.514635963209;4651.302304654295;4653.255479123324;4658.720476771371;6634.436072933807;6641.501887358468;6650.301718319603;6652.8669426611195;6654.301298363699;4713.835015774432;4764.071006153836;4767.809287628456;4772.737499437495;4776.474587795409;4819.879503012453;4820.204666230033;4823.56587907083;4825.10735513931;4825.324454576362;5388.488093631099;5457.126859702428;5477.616566840283;5488.91766623501;5495.148252020863;6451.3226111257645;6457.903131453032;6463.385978332051;6476.449501792306;6482.805515834532;1674.4892807693527;1675.354988329502;1676.740105283683;1677.6057626457773;1678.6486878063033;1176.8999635030948;1179.4279774309452;1181.9586314478952;1210.062201793617;1211.8182272659171;6227.813165605039;6254.061890716338;6260.029695397221;6262.968685156545;6264.21697287839;6650.567713098633;6658.500612454085;6661.40047395727;6663.900041499382;6665.900011499832;6117.694115294217;6197.81406557804;6203.410675985774;6204.937950620526;6206.038064100072;3577.946330804988;3606.2607165531003;3611.602723700391;3611.8013509256716;3614.2410093880053;6658.9001164982565;6823.761168359183;6879.5184337096925;6887.311268873073;6900.516963812585;6758.425533829582;6876.793696189123;6905.343992320722;6921.930780692129;6923.653817309114;6787.2534021257625;6808.863822723518;6868.896966545506;6872.1066261386695;6942.2363540011565;6556.442702370352;6693.598384096969;6712.53012289135;6732.158480189976;6732.932670673231;6638.070670106093;6644.235912870082;6646.83382915431;6652.900206497004;6653.367930046637;6930.549514281555;6938.826529336807;6950;6962.433452473153;6965.756198533027;4687.5781179693995;4748.169070412595;4767.094252092092;4769.332293478847;4772.642051846195;6711.429528490133;6725.562838415487;6728.629925354153;6732.596044237362;6737.9326206737305;6546.116274302908;6547.377999090078;6560.9343906560325;6563.671816409256;6564.737410503526;6351.71417286214;6480.481561475165;6525.608463492205;6531.836704082436;6546.345365463606;6445.645489497935;6450.903236451551;6460.224773027267;6460.418562329413;6466.838329041811;6565.44193743518;6585.946248600201;6594.934050659432;6600.438962688226;6604.7027883746305;6276.968615157078;6436.613803171825;6438.581492202992;6445.25879523842;6445.742170313322 08:48:43 INFO - 2016-02-19 08:48:43,011 DEBUG : BROWSER_OUTPUT: |5;yui.html;781.3514782730334;792.9762107136785;813.2761841960655;916.9908300916991;920.2821798996777;14424.423023079078;14643.780343294846;14724.55826325212;14760.409583616642;14802.925985370059;13349.599512014654;13363.997700172502;13412.93293533531;13445.058845880792;13585.796213056812;715.209693288916;728.5046168605346;902.8284625921087;916.5783739479847;918.0910898210757;860.0238729042519;908.209857424042;911.1435250864199;918.7978644698155;918.8483900156466;750.8836130399769;949.6106596295521;954.141272854433;954.9283803714715;958.6117622362954;750.4971668981796;751.1399447632458;752.7929819299709;753.8869169624545;947.1759569174793;696.3941371007256;697.7278861244118;698.6122701900443;698.6506746626686;699.8915168148945;13290.136141150795;13650;13664.043516953818;13672.521461748891;13690;12897.419616117204;12925.418356173996;13204.273764942924;13628.182309061489;13768.105073170213;10426.687199383954;11088.889111108867;11676.474558644797;11723.648290551297;11946.104042196783;3895.7662540247393;3922.7057970652313;3954.604539546051;3959.6832253419943;3975;45146.548534514564;45289.773551132035;45436.54563454356;45735.54264457346;46098.5390146101;11116.38859862699;11138.832917506244;11316.264442811356;11370.97661210495;11401.600943966921;19367;19464.513387165433;19484.415467535997;19489.317873874345;19516.31692890742;7932.881006784903;8030.7501549907;8091;8126.918730812735;8362.623681934327;4317.503487098961;4448.733076015449;4456.799444025027;4476.664250181249;4594.310853371954;3297.5383446317533;3338.332333533303;3339.933201336008;3342.298117395374;3344.0970937847133;574.9281339832521;582.2954225387244;589.0281036290155;598.3896425645817;603.3483837455537;589.0633892111563;598.4554055809193;665.8701553197177;672.4418732452053;688.6763221285987;8443.493390396474;9419.858702119474;9715.319927605;9857.753556161153;9874.555644995993;521.6166117903338;570.1020892094884;576.9336526299445;598.3059650805133;678.1184460201719;3902.9852238417648;3904.648581627667;3923.7449565778134;4445.555444455528;4527.7509736964785;57220;57340.71329643325;61542.384576153665;62231.377686223466;62518.374816252166;51320.48679513232;51847.48152518427;52177;52298.738506307986;53022.73488632532;48039.75980120077;48307.5169248303;48361.5163848364;48487.757561212675;49563;9198.2181514572;9322.207612353026;9395;9544.475053872104;9583.377080489747;35954;37033.62966370302;37214.25571488501;37471.62528374681;37544.43683344698;44633.33050004317;45963;46468;46561.301580477;47706.761466192445;11467.598634047768;11474.4262786862;12312.569060082855;12392.876071239172;12891.548795792101;11730.296182229093;11764.82352764692;12015.098867584791;12157.452914618687;12673.239605623692;11267.211295209258;11470.483828227916;11485.425728713699;11780;12077.214981026205;11046.834297485704;11302.547898083985;11460.312381257152;11865.762684746429;12072.094592905743;11485.540578377106;11569.88430115688;11606.419679016184;12255.32595707209;12426.254424734545;9794.706158815246;9984.700458986243;10188.89811101909;10396.324238924446;10575.62985295511;9757.756056098655;9816.803663926825;10141.188704903738;10263.640772572924;10332.53503592325 08:48:43 INFO - 2016-02-19 08:48:43,011 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:48:43 INFO - 2016-02-19 08:48:43,011 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:48:43 INFO - 2016-02-19 08:48:43,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,844 08:48:43 INFO - 2016-02-19 08:48:43,012 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:48:43 INFO - 2016-02-19 08:48:43,012 DEBUG : BROWSER_OUTPUT: __startTimestamp1455900523001__endTimestamp 08:48:43 INFO - 2016-02-19 08:48:43,012 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,013 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:48:43 INFO - 2016-02-19 08:48:43,013 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:48:43 INFO - 2016-02-19 08:48:43,013 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,013 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5531.52 Median:5749.74 stddev:609.79 (10.6%) stddev-sans-first:585.65 08:48:43 INFO - 2016-02-19 08:48:43,013 DEBUG : BROWSER_OUTPUT: Values: 3285.6 3359.8 3395.3 3397.6 3419.6 5551.2 5578.9 5594.6 5597.8 5603.6 5520.8 5575.7 5600.4 5600.5 5614.6 4851.0 5064.4 5084.6 5122.8 5184.6 5007.1 5033.9 5064.3 5072.7 5073.9 4891.8 4947.8 4977.8 4984.6 4993.7 5021.4 5101.1 5128.2 5151.1 5168.9 5017.8 5084.1 5104.8 5121.8 5130.5 5257.3 5284.3 5354.7 5372.7 5387.4 5946.1 5948.0 5956.0 5958.3 6036.2 5933.1 5978.9 5983.5 5986.2 5991.2 5383.1 5486.8 5546.1 5588.7 5732.0 5996.9 6033.5 6039.7 6040.3 6042.9 5894.9 5898.6 5899.6 5902.3 5907.6 5627.7 5740.1 5950.8 6062.4 6082.9 5992.0 5998.5 6001.9 6008.7 6013.7 5799.9 5997.7 6000.1 6005.8 6010.9 4484.7 4485.3 4553.8 4568.8 4573.8 4102.8 4112.2 4128.8 4132.4 4152.9 5665.7 5706.5 5725.9 5727.3 5756.0 5762.3 5873.3 5929.6 6029.4 6062.5 5619.5 5653.7 5657.9 5670.9 5674.8 4996.4 5178.2 5181.1 5196.6 5231.2 5927.9 6100.6 6162.3 6174.5 6180.2 6006.2 6032.8 6053.9 6084.8 6091.3 5859.1 5967.4 6234.8 6251.7 6267.3 5800.2 5861.6 5869.6 5877.3 5909.1 5894.4 5939.9 5948.6 5952.6 5954.9 5630.1 5734.5 5786.9 5820.3 5822.9 5837.8 5867.7 5879.6 5880.8 5886.9 5749.7 5753.7 5754.3 5755.2 5790.2 5630.2 5708.6 5775.1 5791.3 5872.9 5727.7 5737.8 5784.9 5785.0 5797.7 08:48:43 INFO - 2016-02-19 08:48:43,014 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,014 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47183.60 Median:34081.50 stddev:77561.82 (227.6%) stddev-sans-first:77700.51 08:48:43 INFO - 2016-02-19 08:48:43,015 DEBUG : BROWSER_OUTPUT: Values: 592.3 624.0 636.4 638.0 642.1 32149.2 42954.1 43777.6 43794.0 43963.3 46315.3 46832.0 46908.8 46910.0 46929.8 7791.9 7898.5 9092.4 9284.4 10541.4 10672.3 10684.4 10787.0 10814.3 10816.6 10719.4 10797.8 10853.2 10856.3 10857.0 8011.2 8181.1 10902.2 11009.5 11075.2 10662.9 10783.1 10790.7 10799.5 10803.8 44487.0 44620.1 44935.3 44997.0 45088.8 3532.5 3663.3 3695.7 3787.8 3820.2 33189.7 33512.5 33542.5 33606.8 33741.7 4208.9 4291.6 4322.7 4352.0 4377.4 306266.0 307952.0 309281.0 310009.0 310283.4 57137.0 58139.0 63670.4 64295.7 73138.4 64904.0 65160.3 65306.0 65585.7 65688.0 14494.7 14558.8 14625.9 14627.2 14657.9 11006.6 11032.6 11039.4 11042.2 11049.9 21343.5 21705.9 21717.3 21734.0 21740.0 8367.2 8478.3 8588.7 8657.2 8712.0 1100.3 1103.2 1128.2 1133.5 1237.9 29610.0 29990.3 30600.5 30743.1 31174.0 1200.6 1234.5 1245.5 1256.4 1298.1 13330.7 15351.5 15788.3 16082.9 16224.0 356616.0 358123.0 358876.0 358923.0 359308.0 56887.0 57158.4 57302.4 57375.0 57478.1 1286.5 1359.7 1439.6 1459.5 1474.0 26965.7 27227.7 27570.3 27958.9 28389.7 41476.0 41830.8 41874.6 41875.4 41888.6 196094.0 197852.0 197854.0 198184.0 198559.0 33965.0 34198.0 34443.7 34485.8 34512.7 43662.6 43672.3 44209.3 44495.6 44753.1 36342.3 36723.8 37677.6 37916.4 38055.0 36595.5 36719.7 36859.4 37300.3 37709.6 37076.8 37137.6 37296.8 38298.2 38999.8 29730.4 29900.6 30078.7 30219.2 30449.4 25176.6 25772.9 25850.0 26454.3 27887.4 08:48:43 INFO - 2016-02-19 08:48:43,015 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,015 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31525.97 Median:11245.08 stddev:100603.05 (894.6%) stddev-sans-first:100858.09 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: Values: 382.9 386.8 397.3 397.4 398.3 14505.5 17351.9 17481.8 18744.3 18755.4 17416.6 17752.0 17758.6 18819.7 19176.1 5068.1 5186.9 5189.8 5190.0 5191.7 3856.8 3958.5 3963.1 3964.1 5149.6 5415.2 5595.7 5603.2 5607.1 5610.2 5409.2 5544.0 5546.8 5557.2 5558.0 5325.2 5342.4 5360.0 5675.9 5685.7 16597.0 20015.6 20457.8 20933.2 21402.7 2219.9 2228.8 2252.2 2358.7 2464.5 10584.7 11077.7 13907.4 14214.8 14354.3 1925.4 2012.5 2031.1 2032.4 2046.4 65488.7 68612.3 69006.7 69290.3 69759.7 11155.9 11299.5 11342.6 11358.4 11381.7 14911.8 15026.6 15063.8 15064.6 15092.2 7963.6 8002.7 8014.0 8054.4 8078.6 7492.3 7496.6 7520.6 7521.4 7563.3 4711.6 4724.9 4739.4 4788.5 4867.0 1686.1 1924.7 1945.8 2002.0 2018.6 978.4 1011.0 1073.0 1078.2 1099.0 17151.3 17577.9 17651.6 18004.2 18117.9 943.7 944.3 964.5 1000.8 1069.0 9962.8 10039.6 10047.2 10112.4 10232.6 566428.0 592907.0 602897.0 656328.0 656794.0 81792.6 82124.6 82878.6 83586.0 84186.2 1203.2 1248.1 1250.3 1251.2 1254.2 15229.4 15457.2 15503.3 15596.8 15699.3 33826.7 34038.7 34278.8 34325.1 34672.8 40835.0 42383.4 42851.8 43268.4 46946.1 9445.6 9807.0 9816.9 9831.4 9834.1 11464.5 11551.1 14160.8 17012.3 17626.0 14762.5 14865.3 15383.4 15711.5 15783.1 14560.5 15073.8 15716.3 15765.6 15832.8 15843.5 15967.8 16176.7 16379.1 16625.1 10127.9 10252.1 10377.5 10418.5 10585.6 15145.3 15560.7 15677.1 15919.5 16145.8 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5852.93 Median:4894.57 stddev:3118.83 (63.7%) stddev-sans-first:3111.07 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: Values: 1583.7 1592.7 1634.7 1816.7 1938.8 7440.3 7587.4 8340.8 8622.3 8628.1 8045.6 8237.5 8335.6 8335.8 8344.3 2283.2 2320.1 2321.6 2323.2 2324.0 2012.2 2050.4 2249.3 2306.4 2333.6 2278.2 2294.3 2296.4 2300.1 2306.4 2279.3 2309.1 2310.4 2311.5 2311.8 2310.0 2333.4 2334.7 2336.0 2337.8 8373.7 8460.1 8460.9 8466.0 8474.7 4780.0 4884.1 4905.0 4917.3 4924.0 3096.8 3126.9 3146.6 3166.9 3167.2 1002.8 1003.8 1007.8 1031.9 1046.6 11501.5 11523.0 11523.3 11526.0 11534.8 4273.5 4310.8 4327.6 4372.6 4387.9 9856.9 9858.9 9871.4 9875.1 9875.5 4793.1 4798.2 4800.8 4808.2 4812.3 4354.2 4357.8 4358.4 4362.6 4363.9 3717.8 3777.2 3812.1 3827.8 3837.1 1058.4 1124.0 1168.5 1184.2 1187.8 1165.9 1189.1 1197.0 1484.5 1505.0 8103.6 8145.9 8205.7 8207.7 8216.8 1180.9 1197.3 1201.6 1222.7 1231.3 6405.6 6451.8 6521.5 6522.8 6524.4 10010.2 10314.9 10315.8 10323.9 10329.8 9550.7 10185.0 10191.1 10197.6 10202.8 8072.7 8154.9 8167.2 8172.1 8182.3 8123.8 8128.1 8225.6 8231.6 8236.3 9208.3 9321.8 9394.4 9431.1 9455.6 9345.5 9424.2 9636.8 9660.2 9692.3 7161.6 7244.1 7258.6 7261.5 7265.5 6954.6 7854.7 7938.2 7947.6 7950.4 6549.7 6554.5 6740.6 7583.1 7588.0 7269.9 7430.4 7526.1 7529.1 7542.5 7359.5 7362.7 7460.5 7480.1 7485.0 7049.9 7095.5 7102.2 7103.6 7111.1 7046.6 7118.8 7182.7 7213.1 7214.8 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5447.94 Median:6194.58 stddev:1611.67 (26.0%) stddev-sans-first:1570.28 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: Values: 359.3 364.8 376.5 377.8 384.8 6051.7 6082.3 6098.7 6101.6 6191.3 6033.8 6035.8 6047.2 6051.8 6052.8 4645.7 4689.2 4709.6 4711.8 4720.9 4710.5 4717.7 4717.7 4723.1 4724.1 4435.7 4533.2 4681.7 4691.1 4702.1 4580.7 4640.6 4673.8 4676.1 4697.3 4145.3 4153.9 4157.0 4169.8 4170.1 5503.5 5621.4 5625.5 5693.5 5765.1 5490.8 5490.9 5493.2 5499.7 5515.7 6437.0 6447.4 6449.0 6455.4 6456.3 4560.3 4622.5 4651.3 4653.3 4658.7 6634.4 6641.5 6650.3 6652.9 6654.3 4713.8 4764.1 4767.8 4772.7 4776.5 4819.9 4820.2 4823.6 4825.1 4825.3 5388.5 5457.1 5477.6 5488.9 5495.1 6451.3 6457.9 6463.4 6476.4 6482.8 1674.5 1675.4 1676.7 1677.6 1678.6 1176.9 1179.4 1182.0 1210.1 1211.8 6227.8 6254.1 6260.0 6263.0 6264.2 6650.6 6658.5 6661.4 6663.9 6665.9 6117.7 6197.8 6203.4 6204.9 6206.0 3577.9 3606.3 3611.6 3611.8 3614.2 6658.9 6823.8 6879.5 6887.3 6900.5 6758.4 6876.8 6905.3 6921.9 6923.7 6787.3 6808.9 6868.9 6872.1 6942.2 6556.4 6693.6 6712.5 6732.2 6732.9 6638.1 6644.2 6646.8 6652.9 6653.4 6930.5 6938.8 6950.0 6962.4 6965.8 4687.6 4748.2 4767.1 4769.3 4772.6 6711.4 6725.6 6728.6 6732.6 6737.9 6546.1 6547.4 6560.9 6563.7 6564.7 6351.7 6480.5 6525.6 6531.8 6546.3 6445.6 6450.9 6460.2 6460.4 6466.8 6565.4 6585.9 6594.9 6600.4 6604.7 6277.0 6436.6 6438.6 6445.3 6445.7 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14331.02 Median:24837.15 stddev:16298.36 (65.6%) stddev-sans-first:16312.32 08:48:43 INFO - 2016-02-19 08:48:43,017 DEBUG : BROWSER_OUTPUT: Values: 781.4 793.0 813.3 917.0 920.3 14424.4 14643.8 14724.6 14760.4 14802.9 13349.6 13364.0 13412.9 13445.1 13585.8 715.2 728.5 902.8 916.6 918.1 860.0 908.2 911.1 918.8 918.8 750.9 949.6 954.1 954.9 958.6 750.5 751.1 752.8 753.9 947.2 696.4 697.7 698.6 698.7 699.9 13290.1 13650.0 13664.0 13672.5 13690.0 12897.4 12925.4 13204.3 13628.2 13768.1 10426.7 11088.9 11676.5 11723.6 11946.1 3895.8 3922.7 3954.6 3959.7 3975.0 45146.5 45289.8 45436.5 45735.5 46098.5 11116.4 11138.8 11316.3 11371.0 11401.6 19367.0 19464.5 19484.4 19489.3 19516.3 7932.9 8030.8 8091.0 8126.9 8362.6 4317.5 4448.7 4456.8 4476.7 4594.3 3297.5 3338.3 3339.9 3342.3 3344.1 574.9 582.3 589.0 598.4 603.3 589.1 598.5 665.9 672.4 688.7 8443.5 9419.9 9715.3 9857.8 9874.6 521.6 570.1 576.9 598.3 678.1 3903.0 3904.6 3923.7 4445.6 4527.8 57220.0 57340.7 61542.4 62231.4 62518.4 51320.5 51847.5 52177.0 52298.7 53022.7 48039.8 48307.5 48361.5 48487.8 49563.0 9198.2 9322.2 9395.0 9544.5 9583.4 35954.0 37033.6 37214.3 37471.6 37544.4 44633.3 45963.0 46468.0 46561.3 47706.8 11467.6 11474.4 12312.6 12392.9 12891.5 11730.3 11764.8 12015.1 12157.5 12673.2 11267.2 11470.5 11485.4 11780.0 12077.2 11046.8 11302.5 11460.3 11865.8 12072.1 11485.5 11569.9 11606.4 12255.3 12426.3 9794.7 9984.7 10188.9 10396.3 10575.6 9757.8 9816.8 10141.2 10263.6 10332.5 08:48:43 INFO - 2016-02-19 08:48:43,018 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:48:43 INFO - 2016-02-19 08:48:43,018 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2016-02-19 08:48:43,578 INFO : Browser exited with error code: 0 08:48:43 INFO - 2016-02-19 08:48:43,606 INFO : Completed test dromaeo_css (00:18:31) 08:48:43 INFO - 2016-02-19 08:48:43,606 INFO : Starting test kraken 08:48:43 INFO - 2016-02-19 08:48:43,606 DEBUG : operating with platform_type : linux_ 08:48:43 INFO - 2016-02-19 08:48:43,606 INFO : Initialising browser for kraken test... 08:48:43 INFO - 2016-02-19 08:48:43,612 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC1Q_ut/profile http://localhost:54510/getInfo.html 08:48:47 INFO - 2016-02-19 08:48:47,601 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:48:47 INFO - 2016-02-19 08:48:47,601 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:48:47 INFO - 2016-02-19 08:48:47,601 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:48:47 INFO - 2016-02-19 08:48:47,601 DEBUG : BROWSER_OUTPUT: __metrics 08:48:47 INFO - 2016-02-19 08:48:47,790 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] 08:48:49 INFO - 2016-02-19 08:48:49,070 INFO : Browser initialized. 08:48:49 INFO - 2016-02-19 08:48:49,070 INFO : Running cycle 1/1 for kraken test... 08:48:49 INFO - 2016-02-19 08:48:49,071 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC1Q_ut/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:49:00 INFO - 2016-02-19 08:49:00,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 133005312 08:49:00 INFO - 2016-02-19 08:49:00,689 DEBUG : BROWSER_OUTPUT: 08:49:03 INFO - 2016-02-19 08:49:03,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54510/tests/kraken/driver.html?testName=audio-beat-detection) 08:49:03 INFO - 2016-02-19 08:49:03,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 163696640 08:49:03 INFO - 2016-02-19 08:49:03,695 DEBUG : BROWSER_OUTPUT: 08:49:06 INFO - 2016-02-19 08:49:06,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54510/tests/kraken/driver.html?testName=audio-dft) 08:49:06 INFO - 2016-02-19 08:49:06,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 161452032 08:49:06 INFO - 2016-02-19 08:49:06,871 DEBUG : BROWSER_OUTPUT: 08:49:09 INFO - 2016-02-19 08:49:09,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54510/tests/kraken/driver.html?testName=audio-fft) 08:49:10 INFO - 2016-02-19 08:49:10,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 158044160 08:49:10 INFO - 2016-02-19 08:49:10,215 DEBUG : BROWSER_OUTPUT: 08:49:12 INFO - 2016-02-19 08:49:12,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54510/tests/kraken/driver.html?testName=audio-oscillator) 08:49:12 INFO - 2016-02-19 08:49:12,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 160235520 08:49:12 INFO - 2016-02-19 08:49:12,766 DEBUG : BROWSER_OUTPUT: 08:49:14 INFO - 2016-02-19 08:49:14,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:15 INFO - 2016-02-19 08:49:15,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 159395840 08:49:15 INFO - 2016-02-19 08:49:15,533 DEBUG : BROWSER_OUTPUT: 08:49:18 INFO - 2016-02-19 08:49:18,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54510/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:18 INFO - 2016-02-19 08:49:18,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 158883840 08:49:18 INFO - 2016-02-19 08:49:18,962 DEBUG : BROWSER_OUTPUT: 08:49:22 INFO - 2016-02-19 08:49:22,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54510/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:22 INFO - 2016-02-19 08:49:22,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 159617024 08:49:22 INFO - 2016-02-19 08:49:22,882 DEBUG : BROWSER_OUTPUT: 08:49:25 INFO - 2016-02-19 08:49:25,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54510/tests/kraken/driver.html?testName=json-parse-financial) 08:49:26 INFO - 2016-02-19 08:49:26,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 160346112 08:49:26 INFO - 2016-02-19 08:49:26,151 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2016-02-19 08:49:27,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:28 INFO - 2016-02-19 08:49:28,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 167583744 08:49:28 INFO - 2016-02-19 08:49:28,281 DEBUG : BROWSER_OUTPUT: 08:49:30 INFO - 2016-02-19 08:49:30,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:30 INFO - 2016-02-19 08:49:30,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 166567936 08:49:30 INFO - 2016-02-19 08:49:30,663 DEBUG : BROWSER_OUTPUT: 08:49:32 INFO - 2016-02-19 08:49:32,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:33 INFO - 2016-02-19 08:49:33,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 169394176 08:49:33 INFO - 2016-02-19 08:49:33,173 DEBUG : BROWSER_OUTPUT: 08:49:35 INFO - 2016-02-19 08:49:35,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:36 INFO - 2016-02-19 08:49:36,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 178692096 08:49:36 INFO - 2016-02-19 08:49:36,085 DEBUG : BROWSER_OUTPUT: 08:49:38 INFO - 2016-02-19 08:49:38,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:39 INFO - 2016-02-19 08:49:39,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 176844800 08:49:39 INFO - 2016-02-19 08:49:39,158 DEBUG : BROWSER_OUTPUT: 08:49:40 INFO - 2016-02-19 08:49:40,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54510/tests/kraken/driver.html?testName=ai-astar) 08:49:41 INFO - 2016-02-19 08:49:41,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 234168320 08:49:41 INFO - 2016-02-19 08:49:41,059 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,060 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:49:41 INFO - 2016-02-19 08:49:41,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:49:41 INFO - 2016-02-19 08:49:41,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:49:41 INFO - 2016-02-19 08:49:41,060 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:49:41 INFO - 2016-02-19 08:49:41,060 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;109;110;110;99;111;111;108 08:49:41 INFO - 2016-02-19 08:49:41,061 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;136;158;162;122;144;149;126;161;123 08:49:41 INFO - 2016-02-19 08:49:41,061 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;159;159;162;160;159;159;160;159 08:49:41 INFO - 2016-02-19 08:49:41,061 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;71;145;72;72;71;73;156;72 08:49:41 INFO - 2016-02-19 08:49:41,061 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;98;92;135;91;92;93;141;91;92;143 08:49:41 INFO - 2016-02-19 08:49:41,061 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;108;108;109;109;109;109 08:49:41 INFO - 2016-02-19 08:49:41,061 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;145;145;145;145;145;145 08:49:41 INFO - 2016-02-19 08:49:41,063 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;95;95;95;95;95 08:49:41 INFO - 2016-02-19 08:49:41,063 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;55;57;56;58;56;56;57;54 08:49:41 INFO - 2016-02-19 08:49:41,063 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;65;66;66;65;65;70;65;66 08:49:41 INFO - 2016-02-19 08:49:41,063 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;76;77;77;76;86;78;77;86;80 08:49:41 INFO - 2016-02-19 08:49:41,063 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;110;117;111;116;115;114;119;111;115 08:49:41 INFO - 2016-02-19 08:49:41,064 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;140;144;139;145;131;142;141;153;129 08:49:41 INFO - 2016-02-19 08:49:41,064 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;66;62;65;62;64;63;63;63 08:49:41 INFO - 2016-02-19 08:49:41,064 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:49:41 INFO - 2016-02-19 08:49:41,064 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:49:41 INFO - 2016-02-19 08:49:41,064 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,888 08:49:41 INFO - 2016-02-19 08:49:41,065 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:49:41 INFO - 2016-02-19 08:49:41,065 DEBUG : BROWSER_OUTPUT: __startTimestamp1455900581058__endTimestamp 08:49:41 INFO - 2016-02-19 08:49:41,065 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,066 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:49:41 INFO - 2016-02-19 08:49:41,067 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:49:41 INFO - 2016-02-19 08:49:41,067 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,067 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.67 (3.3%) stddev-sans-first:3.89 08:49:41 INFO - 2016-02-19 08:49:41,067 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 109.0 110.0 110.0 99.0 111.0 111.0 108.0 08:49:41 INFO - 2016-02-19 08:49:41,067 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,068 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.50 stddev:15.66 (10.4%) stddev-sans-first:16.29 08:49:41 INFO - 2016-02-19 08:49:41,068 DEBUG : BROWSER_OUTPUT: Values: 152.0 136.0 158.0 162.0 122.0 144.0 149.0 126.0 161.0 123.0 08:49:41 INFO - 2016-02-19 08:49:41,068 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,068 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 08:49:41 INFO - 2016-02-19 08:49:41,068 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 159.0 159.0 162.0 160.0 159.0 159.0 160.0 159.0 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.70 Median:72.00 stddev:33.21 (46.1%) stddev-sans-first:34.79 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 71.0 145.0 72.0 72.0 71.0 73.0 156.0 72.0 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:92.00 stddev:22.85 (24.8%) stddev-sans-first:24.01 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: Values: 98.0 92.0 135.0 91.0 92.0 93.0 141.0 91.0 92.0 143.0 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,069 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:49:41 INFO - 2016-02-19 08:49:41,070 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 108.0 108.0 109.0 109.0 109.0 109.0 08:49:41 INFO - 2016-02-19 08:49:41,070 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,070 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:49:41 INFO - 2016-02-19 08:49:41,070 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 08:49:41 INFO - 2016-02-19 08:49:41,070 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,070 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.15 (2.1%) stddev-sans-first:1.17 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 55.0 57.0 56.0 58.0 56.0 56.0 57.0 54.0 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.58 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 66.0 66.0 65.0 65.0 70.0 65.0 66.0 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:77.50 stddev:3.93 (5.1%) stddev-sans-first:4.02 08:49:41 INFO - 2016-02-19 08:49:41,071 DEBUG : BROWSER_OUTPUT: Values: 76.0 76.0 77.0 77.0 76.0 86.0 78.0 77.0 86.0 80.0 08:49:41 INFO - 2016-02-19 08:49:41,072 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,072 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:115.00 stddev:3.03 (2.6%) stddev-sans-first:3.03 08:49:41 INFO - 2016-02-19 08:49:41,072 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 117.0 111.0 116.0 115.0 114.0 119.0 111.0 115.0 08:49:41 INFO - 2016-02-19 08:49:41,072 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,072 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.50 Median:141.50 stddev:7.43 (5.2%) stddev-sans-first:7.21 08:49:41 INFO - 2016-02-19 08:49:41,073 DEBUG : BROWSER_OUTPUT: Values: 131.0 140.0 144.0 139.0 145.0 131.0 142.0 141.0 153.0 129.0 08:49:41 INFO - 2016-02-19 08:49:41,073 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,073 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 08:49:41 INFO - 2016-02-19 08:49:41,073 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 66.0 62.0 65.0 62.0 64.0 63.0 63.0 63.0 08:49:41 INFO - 2016-02-19 08:49:41,073 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:49:41 INFO - 2016-02-19 08:49:41,073 DEBUG : BROWSER_OUTPUT: 08:49:41 INFO - 2016-02-19 08:49:41,786 INFO : Browser exited with error code: 0 08:49:41 INFO - 2016-02-19 08:49:41,840 INFO : Completed test kraken (00:00:58) 08:49:41 INFO - 2016-02-19 08:49:41,840 INFO : Starting test v8_7 08:49:41 INFO - 2016-02-19 08:49:41,840 DEBUG : operating with platform_type : linux_ 08:49:41 INFO - 2016-02-19 08:49:41,840 INFO : Initialising browser for v8_7 test... 08:49:41 INFO - 2016-02-19 08:49:41,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2M2et1/profile http://localhost:54510/getInfo.html 08:49:46 INFO - 2016-02-19 08:49:46,299 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:49:46 INFO - 2016-02-19 08:49:46,300 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:49:46 INFO - 2016-02-19 08:49:46,300 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:49:46 INFO - 2016-02-19 08:49:46,300 DEBUG : BROWSER_OUTPUT: __metrics 08:49:46 INFO - 2016-02-19 08:49:46,489 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] 08:49:47 INFO - 2016-02-19 08:49:47,354 INFO : Browser initialized. 08:49:47 INFO - 2016-02-19 08:49:47,354 INFO : Running cycle 1/1 for v8_7 test... 08:49:47 INFO - 2016-02-19 08:49:47,355 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2M2et1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:49:59 INFO - 2016-02-19 08:49:59,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 133554176 08:49:59 INFO - 2016-02-19 08:49:59,040 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54510/tests/v8_7/run.html (next: http://localhost:54510/tests/v8_7/run.html) 08:50:20 INFO - 2016-02-19 08:50:20,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 421761024 08:50:20 INFO - 2016-02-19 08:50:20,654 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,654 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:50:20 INFO - 2016-02-19 08:50:20,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:50:20 INFO - 2016-02-19 08:50:20,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:50:20 INFO - 2016-02-19 08:50:20,655 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:50:20 INFO - 2016-02-19 08:50:20,655 DEBUG : BROWSER_OUTPUT: |0;Richards;166.91704223001167 08:50:20 INFO - 2016-02-19 08:50:20,655 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.74464579901152 08:50:20 INFO - 2016-02-19 08:50:20,655 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.9321845469705 08:50:20 INFO - 2016-02-19 08:50:20,656 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 08:50:20 INFO - 2016-02-19 08:50:20,656 DEBUG : BROWSER_OUTPUT: |4;RayTrace;957.8544061302682 08:50:20 INFO - 2016-02-19 08:50:20,656 DEBUG : BROWSER_OUTPUT: |5;Earley;544.069640914037 08:50:20 INFO - 2016-02-19 08:50:20,656 DEBUG : BROWSER_OUTPUT: |6;Boyer;10402.061855670103 08:50:20 INFO - 2016-02-19 08:50:20,656 DEBUG : BROWSER_OUTPUT: |7;RegExp;24023.809523809523 08:50:20 INFO - 2016-02-19 08:50:20,656 DEBUG : BROWSER_OUTPUT: |8;Splay;533.3333333333334 08:50:20 INFO - 2016-02-19 08:50:20,657 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 08:50:20 INFO - 2016-02-19 08:50:20,657 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:50:20 INFO - 2016-02-19 08:50:20,657 DEBUG : BROWSER_OUTPUT: __startTimestamp1455900620652__endTimestamp 08:50:20 INFO - 2016-02-19 08:50:20,657 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,657 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:50:20 INFO - 2016-02-19 08:50:20,657 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:50:20 INFO - 2016-02-19 08:50:20,657 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: Values: 166.9 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.74 Median:164.74 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: Values: 164.7 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: Values: 277.9 08:50:20 INFO - 2016-02-19 08:50:20,658 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: Values: 5196.9 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:957.85 Median:957.85 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: Values: 957.9 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.07 Median:544.07 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: Values: 544.1 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,659 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10402.06 Median:10402.06 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,660 DEBUG : BROWSER_OUTPUT: Values: 10402.1 08:50:20 INFO - 2016-02-19 08:50:20,660 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,660 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24023.81 Median:24023.81 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,660 DEBUG : BROWSER_OUTPUT: Values: 24023.8 08:50:20 INFO - 2016-02-19 08:50:20,660 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,661 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:533.33 Median:533.33 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,661 DEBUG : BROWSER_OUTPUT: Values: 533.3 08:50:20 INFO - 2016-02-19 08:50:20,661 DEBUG : BROWSER_OUTPUT: 08:50:20 INFO - 2016-02-19 08:50:20,661 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 08:50:20 INFO - 2016-02-19 08:50:20,661 DEBUG : BROWSER_OUTPUT: Values: 4822.1 08:50:20 INFO - 2016-02-19 08:50:20,661 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:50:20 INFO - 2016-02-19 08:50:20,661 DEBUG : BROWSER_OUTPUT: 08:50:21 INFO - 2016-02-19 08:50:21,374 INFO : Browser exited with error code: 0 08:50:21 INFO - 2016-02-19 08:50:21,390 INFO : Completed test v8_7 (00:00:39) 08:50:21 INFO - 2016-02-19 08:50:21,694 INFO : Completed test suite (00:20:09) 08:50:21 INFO - 2016-02-19 08:50:21,695 DEBUG : Working with test: dromaeo_css 08:50:21 INFO - 2016-02-19 08:50:21,695 DEBUG : Generating results file: dromaeo_css 08:50:21 INFO - 2016-02-19 08:50:21,696 DEBUG : Working with test: kraken 08:50:21 INFO - 2016-02-19 08:50:21,696 DEBUG : Generating results file: kraken 08:50:21 INFO - 2016-02-19 08:50:21,696 INFO : javascript benchmark 08:50:21 INFO - 2016-02-19 08:50:21,696 DEBUG : Working with test: v8_7 08:50:21 INFO - 2016-02-19 08:50:21,696 DEBUG : Generating results file: v8_7 08:50:21 INFO - 2016-02-19 08:50:21,697 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:50:21 INFO - 2016-02-19 08:50:21,819 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 08:50:21 INFO - 2016-02-19 08:50:21,819 DEBUG : process_Request line: dromaeo_css 7333.96 graph.html#tests=[[72,53,35]] 08:50:21 INFO - 2016-02-19 08:50:21,819 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:50:21 INFO - 2016-02-19 08:50:21,843 DEBUG : process_Request line: kraken 1473.00 graph.html#tests=[[232,53,35]] 08:50:21 INFO - 2016-02-19 08:50:21,843 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:50:21 INFO - 2016-02-19 08:50:21,874 DEBUG : process_Request line: v8_7 23280.45 graph.html#tests=[[230,53,35]] 08:50:21 INFO - 2016-02-19 08:50:21,876 INFO : javascript benchmark 08:50:21 INFO - 2016-02-19 08:50:21,879 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3285.622153452353, 3359.815210163443, 3395.2530443302467, 3397.6092749333834, 3419.5896492420907, 5551.2228288039705, 5578.888422231553, 5594.636348637341, 5597.832065038046, 5603.551715862732, 5520.806771762989, 5575.749091290892, 5600.355959064709, 5600.52395546378, 5614.550835933126, 4850.951490485103, 5064.417591976915, 5084.618653600976, 5122.795088196468, 5184.559312458427, 5007.123753343169, 5033.874153146182, 5064.3163172971545, 5072.72100034498, 5073.949260507385, 4891.755412229392, 4947.8268260610885, 4977.776000080005, 4984.601231901439, 4993.650444468889, 5021.39743230811, 5101.107306221415, 5128.205128205134, 5151.072806894757, 5168.9224661630105, 5017.84946451607, 5084.135696931494, 5104.846854594368, 5121.795128194905, 5130.53825155734, 5257.342832145981, 5284.286621306152, 5354.732263386854, 5372.7313634318125, 5387.353517577876, 5946.108083787423, 5948.018576934801, 5955.970220148914, 5958.314793798725, 6036.215292012054, 5933.139694744281, 5978.910316345258, 5983.491403230731, 5986.2217911671205, 5991.191189189447, 5383.057964856134, 5486.780528778844, 5546.112621980464, 5588.720563971826, 5732.0, 5996.850078747979, 6033.487153591994, 6039.667818270037, 6040.275166979903, 6042.939570604326, 5894.941050589525, 5898.616589921641, 5899.587028908021, 5902.321233058167, 5907.61600495975, 5627.690477023803, 5740.052891272977, 5950.821475355746, 6062.363451837494, 6082.878342433127, 5992.0, 5998.49012833914, 6001.879962400728, 6008.669523176267, 6013.6993150342305, 5799.942000580025, 5997.730102145414, 6000.0699891516015, 6005.849853753603, 6010.909836352458, 4484.686071974996, 4485.259932111165, 4553.840615578439, 4568.771561421916, 4573.771311434415, 4102.774347410921, 4112.198121366305, 4128.772917489567, 4132.380142978577, 4152.875413737593, 5665.745041473144, 5706.457886500776, 5725.942740572625, 5727.284089488814, 5756.0, 5762.337331206881, 5873.295204575478, 5929.644221346733, 6029.397060293935, 6062.454379105901, 5619.494245517842, 5653.717314134276, 5657.915131273035, 5670.943290567042, 5674.77300907959, 4996.375453068366, 5178.171492561172, 5181.145111056633, 5196.610254230872, 5231.189165679326, 5927.911081333784, 6100.603460775035, 6162.322144564095, 6174.475169610633, 6180.227471566144, 6006.189164462741, 6032.819015429544, 6053.878922421615, 6084.787032453843, 6091.299500557493, 5859.091840764689, 5967.433093856077, 6234.770606086284, 6251.718672659832, 6267.2792628848265, 5800.24596802413, 5861.648301101947, 5869.618474799125, 5877.324107727495, 5909.054551271776, 5894.410558944242, 5939.881202375842, 5948.583599148018, 5952.642841429528, 5954.880902381841, 5630.127330263816, 5734.5125664319, 5786.94213057864, 5820.330661973927, 5822.912656310244, 5837.766489340379, 5867.73595188209, 5879.647221166743, 5880.8235752927485, 5886.852828679146, 5749.741261643152, 5753.683547404933, 5754.251947246831, 5755.165501002248, 5790.24726785532, 5630.211770352236, 5708.600397972268, 5775.104858746901, 5791.333996590446, 5872.882542349214, 5727.6849773262875, 5737.770489180553, 5784.913226301693, 5785.0, 5797.739101740347], "unit": "ms", "name": "dojo.html", "value": 5492.614921856073}, {"lowerIsBetter": false, "replicates": [592.2685483427965, 623.9937600623992, 636.4272155060445, 638.0238235499684, 642.1267076775584, 32149.19627009326, 42954.140917181634, 43777.56222437775, 43794.0, 43963.34054989178, 46315.30527042097, 46832.0, 46908.765456172754, 46910.0, 46929.7653511732, 7791.883121753178, 7898.526088434713, 9092.363534552584, 9284.396514226553, 10541.420221887793, 10672.252942294042, 10684.358938463678, 10787.029167374934, 10814.29707069038, 10816.567337306498, 10719.410432426213, 10797.83803242952, 10853.24027318088, 10856.34861908288, 10857.0, 8011.198880111971, 8181.059178194524, 10902.182336324808, 11009.504572294267, 11075.16936229778, 10662.893371066268, 10783.13734901206, 10790.67627971162, 10799.514021869034, 10803.83794243087, 44487.0, 44620.10759784819, 44935.32597011015, 44997.0, 45088.77455612734, 3532.4701294805727, 3663.3222853772136, 3695.6858667013335, 3787.7537960032787, 3820.2168555446065, 33189.6681033189, 33512.497312540334, 33542.49686254708, 33606.83196584026, 33741.6625833741, 4208.915821683579, 4291.635211007068, 4322.654187665011, 4352.0, 4377.409049778271, 306266.0, 307952.0, 309281.0, 310009.0, 310283.4485827579, 57137.0, 58139.0, 63670.363296367366, 64295.67852160709, 73138.44015459434, 64904.0, 65160.34839651543, 65306.0, 65585.67207163933, 65688.0, 14494.710105798036, 14558.781618275734, 14625.926870365793, 14627.195504247156, 14657.853421465648, 11006.614768483065, 11032.558697652004, 11039.39283339408, 11042.171837112248, 11049.889501105046, 21343.46641333948, 21705.891470542545, 21717.34847954564, 21734.0, 21740.0, 8367.205115514016, 8478.279346255515, 8588.742337729878, 8657.177568131017, 8712.0, 1100.2683215661496, 1103.172620534599, 1128.2440764687678, 1133.4616057372682, 1237.8576463706788, 29610.0, 29990.250243743645, 30600.54099188514, 30743.077707668806, 31174.0, 1200.5737963023, 1234.5185377702703, 1245.5017992802952, 1256.4094875408543, 1298.104308027458, 13330.666733331744, 15351.462698805488, 15788.289526971314, 16082.919585402233, 16224.026558406533, 356616.0, 358123.0, 358876.0, 358923.0, 359308.0, 56887.0, 57158.428415716146, 57302.42697572971, 57375.0, 57478.137827932616, 1286.4789760147155, 1359.6736783171968, 1439.6113049476583, 1459.4745891479272, 1473.977890331646, 26965.730342696323, 27227.72772272252, 27570.310742231606, 27958.860205699653, 28389.716102839535, 41476.0, 41830.79084604557, 41874.58125418707, 41875.37186942259, 41888.58111418847, 196094.0, 197852.0, 197854.0, 198184.0, 198559.0, 33965.0, 34198.0, 34443.655563444045, 34485.827570861984, 34512.65487345094, 43662.56337436585, 43672.344914826936, 44209.33685994777, 44495.55504444914, 44753.10493790171, 36342.27315453729, 36723.816380917924, 37677.62322376741, 37916.43125353177, 38055.0, 36595.45106823453, 36719.66593994315, 36859.44710829286, 37300.253994920495, 37709.622903771706, 37076.81461592675, 37137.628623714496, 37296.81351593225, 38298.23403531969, 38999.80500097481, 29730.405391892473, 29900.551491728078, 30078.699213008465, 30219.244518886324, 30449.39101217919, 25176.622350665122, 25772.8711356442, 25850.0, 26454.338641534116, 27887.442251154458], "unit": "ms", "name": "ext.html", "value": 19601.020236383152}, {"lowerIsBetter": false, "replicates": [382.8966179131634, 386.7602086706242, 397.276955940189, 397.36024999750396, 398.3486998757031, 14505.492307769231, 17351.913240433794, 17481.82518174818, 18744.343947961806, 18755.4373368799, 17416.56458588536, 17752.0, 17758.55603609907, 18819.717704234412, 19176.137073831676, 5068.1384164692, 5186.92219616706, 5189.8183563575285, 5189.999999999981, 5191.714455704935, 3856.84572617095, 3958.5447673517624, 3963.1479231965122, 3964.0684439156776, 5149.639525233235, 5415.214793854889, 5595.692236926988, 5603.2435621191025, 5607.074832652607, 5610.214569960209, 5409.188621706736, 5543.972280138614, 5546.750396232159, 5557.166425036236, 5557.972210138963, 5325.227841962894, 5342.385625653061, 5360.0, 5675.886482270373, 5685.715714214272, 16597.004179749132, 20015.599688006158, 20457.79542204574, 20933.162673493043, 21402.678959815614, 2219.933401997943, 2228.832837537191, 2252.2342403582697, 2358.716953965535, 2464.4824586836785, 10584.735381615445, 11077.723056923562, 13907.443702251898, 14214.786778198335, 14354.282285885769, 1925.431997560723, 2012.537116463207, 2031.1063132221775, 2032.3699653107583, 2046.4372297618124, 65488.67255663691, 68612.3138768611, 69006.65496672534, 69290.3070969289, 69759.65120174366, 11155.944220278847, 11299.54801807935, 11342.60300889465, 11358.375289359165, 11381.715457113638, 14911.776323355158, 15026.647601715898, 15063.774043389358, 15064.623384415258, 15092.245387730569, 7963.641636126388, 8002.7199048033035, 8013.959930200312, 8054.355651547862, 8078.555679437687, 7492.325690687755, 7496.550206987598, 7520.586367749826, 7521.398288136936, 7563.319301262913, 4711.552402521755, 4724.929126063112, 4739.431268247763, 4788.473267940523, 4866.9513304867205, 1686.110640712887, 1924.7401600783714, 1945.834604058671, 2002.0, 2018.6063717574932, 978.3591747405461, 1010.9797804044025, 1073.0235485707967, 1078.185969592968, 1098.9780204395868, 17151.313947442213, 17577.912110439367, 17651.55871103207, 18004.189811458516, 18117.909410452863, 943.6697155995347, 944.3200895355333, 964.4984608003939, 1000.7698229407132, 1069.0165048155716, 9962.800743985079, 10039.598416063276, 10047.24645651579, 10112.393256404639, 10232.59069637221, 566428.0, 592907.0, 602897.0, 656328.0, 656794.0, 81792.59103704443, 82124.58937705393, 82878.58560707158, 83586.0, 84186.15813841783, 1203.175824560179, 1248.0577164241122, 1250.287336218365, 1251.2429979862052, 1254.1534464236786, 15229.400912903986, 15457.227138643248, 15503.302351393988, 15596.84403155954, 15699.293531790869, 33826.66173338235, 34038.65961340454, 34278.82860585681, 34325.141871453416, 34672.82663586666, 40835.0, 42383.3642495369, 42851.78574107109, 43268.35097473478, 46946.06107877755, 9445.574949127444, 9806.950965245414, 9816.852747208655, 9831.410115393099, 9834.114929656365, 11464.484098215433, 11551.133664975328, 14160.78758818598, 17012.31950722007, 17626.0, 14762.48331308399, 14865.331060102106, 15383.38466461329, 15711.450099246471, 15783.131927744083, 14560.490382836973, 15073.773893391388, 15716.292766825292, 15765.605859853136, 15832.762508562151, 15843.524694259191, 15967.760483592523, 16176.67646647037, 16379.09914954689, 16625.085620291, 10127.89872101299, 10252.128569071712, 10377.533011014371, 10418.531166097695, 10585.623868896993, 15145.318460669076, 15560.688786224438, 15677.05937643745, 15919.522414327588, 16145.75781363257], "unit": "ms", "name": "jquery.html", "value": 9320.834066686877}, {"lowerIsBetter": false, "replicates": [1583.7386831172857, 1592.6894255620143, 1634.7466142747871, 1816.745655608215, 1938.7576552930875, 7440.330370266675, 7587.393008559316, 8340.83318333633, 8622.310215182779, 8628.050914399411, 8045.597720114, 8237.50574965501, 8335.624896879639, 8335.791605209874, 8344.332453403727, 2283.189467738958, 2320.141547627372, 2321.58211521926, 2323.233333000106, 2323.9535209295805, 2012.2051789543123, 2050.425880753384, 2249.3364457485, 2306.3657494189065, 2333.603287441139, 2278.1798552521077, 2294.27730264966, 2296.437372843656, 2300.148944890393, 2306.3888069661552, 2279.327598358488, 2309.0532881518498, 2310.387747246981, 2311.5376924614975, 2311.8150547956125, 2309.953800923989, 2333.4166458385403, 2334.661474086265, 2336.0422226886894, 2337.789598936104, 8373.706920257762, 8460.069392366835, 8460.8730869037, 8466.026406963216, 8474.661013559451, 4779.976100119512, 4884.145274576935, 4905.0, 4917.311576379309, 4923.950760492385, 3096.8451577421265, 3126.8749250029973, 3146.6224053113774, 3166.857491412892, 3167.224030112637, 1002.7543251903257, 1003.8494225866178, 1007.8286691262502, 1031.9484025798756, 1046.6284469013467, 11501.539938402453, 11523.0, 11523.250988685708, 11526.0, 11534.769304613945, 4273.508546517128, 4310.762908040025, 4327.632151267115, 4372.606465418127, 4387.912241755147, 9856.852147217798, 9858.852117218248, 9871.358361706467, 9875.111239988435, 9875.506224688737, 4793.065352256346, 4798.2082956311815, 4800.7599620019555, 4808.206645903457, 4812.326274321597, 4354.216241076637, 4357.782110894443, 4358.411614432074, 4362.563743625612, 4363.869083927487, 3717.75834570752, 3777.150141218259, 3812.0660438192267, 3827.8086095695103, 3837.059920319484, 1058.380847204394, 1123.966281011571, 1168.5033860609208, 1184.2006645514243, 1187.821826725998, 1165.9008984236266, 1189.1102534682445, 1196.9945245993408, 1484.502691598305, 1504.9623759406102, 8103.594820258963, 8145.918540814635, 8205.71280005197, 8207.71273005442, 8216.835663286702, 1180.8582970043649, 1197.275648232824, 1201.6094769200045, 1222.6515443098674, 1231.2673958994385, 6405.551611387158, 6451.838704032437, 6521.543491955517, 6522.771702990467, 6524.380183882524, 10010.199184065257, 10314.948425257826, 10315.793684126276, 10323.896761032294, 10329.84505232422, 9550.665726699532, 10185.0, 10191.133753631024, 10197.643082492077, 10202.795944081077, 8072.677092916218, 8154.918450815535, 8167.183281671785, 8172.060213075572, 8182.263596276363, 8123.837523249384, 8128.105908349959, 8225.588720564068, 8231.629576668944, 8236.34109271245, 9208.309376796633, 9321.766955826159, 9394.436333819993, 9431.056894310514, 9455.621775129193, 9345.48599827016, 9424.246060315296, 9636.75908102303, 9660.227181825578, 9692.321537492307, 7161.57030578167, 7244.058272424551, 7258.637068146677, 7261.5280006799385, 7265.4550908681, 6954.582725036514, 7854.6858125674335, 7938.166492518202, 7947.642356094106, 7950.40371972116, 6549.672516374067, 6554.476526537413, 6740.561863478858, 7583.127940286938, 7587.962060189664, 7269.854602907806, 7430.44271679637, 7526.09686837583, 7529.13414957265, 7542.47202695806, 7359.521631093961, 7362.6686799093095, 7460.477766556506, 7480.102387713509, 7485.0, 7049.859002820018, 7095.46783991213, 7102.218755936946, 7103.609301488468, 7111.075560177143, 7046.577205367695, 7118.750843720445, 7182.712691492491, 7213.134423868959, 7214.783556493314], "unit": "ms", "name": "mootools.html", "value": 4756.955256900253}, {"lowerIsBetter": false, "replicates": [359.29578027066947, 364.7793085183464, 376.4752751357004, 377.83752986215916, 384.8287512057134, 6051.667158306292, 6082.330943596206, 6098.695065246742, 6101.633901965874, 6191.3499082596245, 6033.849153771147, 6035.758569657209, 6047.15339852421, 6051.78818741343, 6052.818415447533, 4645.721256724591, 4689.155951928651, 4709.552592503724, 4711.835085771999, 4720.929186062194, 4710.458297295821, 4717.740524271164, 4717.740524271164, 4723.055388922229, 4724.078804633098, 4435.711678740888, 4533.2066888294585, 4681.74250416227, 4691.0617876424685, 4702.05958808238, 4580.725156490605, 4640.628749700016, 4673.836415725467, 4676.0647870426055, 4697.295405689174, 4145.336746120606, 4153.875383738462, 4157.043879907638, 4169.812358443877, 4170.145120250371, 5503.504684578367, 5621.353544342412, 5625.493705566519, 5693.5445164387165, 5765.106408506646, 5490.835274941758, 5490.890182196374, 5493.176023596453, 5499.697516636584, 5515.669059856381, 6436.967815160894, 6447.387498187664, 6448.967755161241, 6455.354464553554, 6456.289808121103, 4560.315952607102, 4622.514635963209, 4651.302304654295, 4653.255479123324, 4658.720476771371, 6634.436072933807, 6641.501887358468, 6650.301718319603, 6652.8669426611195, 6654.301298363699, 4713.835015774432, 4764.071006153836, 4767.809287628456, 4772.737499437495, 4776.474587795409, 4819.879503012453, 4820.204666230033, 4823.56587907083, 4825.10735513931, 4825.324454576362, 5388.488093631099, 5457.126859702428, 5477.616566840283, 5488.91766623501, 5495.148252020863, 6451.3226111257645, 6457.903131453032, 6463.385978332051, 6476.449501792306, 6482.805515834532, 1674.4892807693527, 1675.354988329502, 1676.740105283683, 1677.6057626457773, 1678.6486878063033, 1176.8999635030948, 1179.4279774309452, 1181.9586314478952, 1210.062201793617, 1211.8182272659171, 6227.813165605039, 6254.061890716338, 6260.029695397221, 6262.968685156545, 6264.21697287839, 6650.567713098633, 6658.500612454085, 6661.40047395727, 6663.900041499382, 6665.900011499832, 6117.694115294217, 6197.81406557804, 6203.410675985774, 6204.937950620526, 6206.038064100072, 3577.946330804988, 3606.2607165531003, 3611.602723700391, 3611.8013509256716, 3614.2410093880053, 6658.9001164982565, 6823.761168359183, 6879.5184337096925, 6887.311268873073, 6900.516963812585, 6758.425533829582, 6876.793696189123, 6905.343992320722, 6921.930780692129, 6923.653817309114, 6787.2534021257625, 6808.863822723518, 6868.896966545506, 6872.1066261386695, 6942.2363540011565, 6556.442702370352, 6693.598384096969, 6712.53012289135, 6732.158480189976, 6732.932670673231, 6638.070670106093, 6644.235912870082, 6646.83382915431, 6652.900206497004, 6653.367930046637, 6930.549514281555, 6938.826529336807, 6950.0, 6962.433452473153, 6965.756198533027, 4687.5781179693995, 4748.169070412595, 4767.094252092092, 4769.332293478847, 4772.642051846195, 6711.429528490133, 6725.562838415487, 6728.629925354153, 6732.596044237362, 6737.9326206737305, 6546.116274302908, 6547.377999090078, 6560.9343906560325, 6563.671816409256, 6564.737410503526, 6351.71417286214, 6480.481561475165, 6525.608463492205, 6531.836704082436, 6546.345365463606, 6445.645489497935, 6450.903236451551, 6460.224773027267, 6460.418562329413, 6466.838329041811, 6565.44193743518, 6585.946248600201, 6594.934050659432, 6600.438962688226, 6604.7027883746305, 6276.968615157078, 6436.613803171825, 6438.581492202992, 6445.25879523842, 6445.742170313322], "unit": "ms", "name": "prototype.html", "value": 4938.187143468391}, {"lowerIsBetter": false, "replicates": [781.3514782730334, 792.9762107136785, 813.2761841960655, 916.9908300916991, 920.2821798996777, 14424.423023079078, 14643.780343294846, 14724.55826325212, 14760.409583616642, 14802.925985370059, 13349.599512014654, 13363.997700172502, 13412.93293533531, 13445.058845880792, 13585.796213056812, 715.209693288916, 728.5046168605346, 902.8284625921087, 916.5783739479847, 918.0910898210757, 860.0238729042519, 908.209857424042, 911.1435250864199, 918.7978644698155, 918.8483900156466, 750.8836130399769, 949.6106596295521, 954.141272854433, 954.9283803714715, 958.6117622362954, 750.4971668981796, 751.1399447632458, 752.7929819299709, 753.8869169624545, 947.1759569174793, 696.3941371007256, 697.7278861244118, 698.6122701900443, 698.6506746626686, 699.8915168148945, 13290.136141150795, 13650.0, 13664.043516953818, 13672.521461748891, 13690.0, 12897.419616117204, 12925.418356173996, 13204.273764942924, 13628.182309061489, 13768.105073170213, 10426.687199383954, 11088.889111108867, 11676.474558644797, 11723.648290551297, 11946.104042196783, 3895.7662540247393, 3922.7057970652313, 3954.604539546051, 3959.6832253419943, 3975.0, 45146.548534514564, 45289.773551132035, 45436.54563454356, 45735.54264457346, 46098.5390146101, 11116.38859862699, 11138.832917506244, 11316.264442811356, 11370.97661210495, 11401.600943966921, 19367.0, 19464.513387165433, 19484.415467535997, 19489.317873874345, 19516.31692890742, 7932.881006784903, 8030.7501549907, 8091.0, 8126.918730812735, 8362.623681934327, 4317.503487098961, 4448.733076015449, 4456.799444025027, 4476.664250181249, 4594.310853371954, 3297.5383446317533, 3338.332333533303, 3339.933201336008, 3342.298117395374, 3344.0970937847133, 574.9281339832521, 582.2954225387244, 589.0281036290155, 598.3896425645817, 603.3483837455537, 589.0633892111563, 598.4554055809193, 665.8701553197177, 672.4418732452053, 688.6763221285987, 8443.493390396474, 9419.858702119474, 9715.319927605, 9857.753556161153, 9874.555644995993, 521.6166117903338, 570.1020892094884, 576.9336526299445, 598.3059650805133, 678.1184460201719, 3902.9852238417648, 3904.648581627667, 3923.7449565778134, 4445.555444455528, 4527.7509736964785, 57220.0, 57340.71329643325, 61542.384576153665, 62231.377686223466, 62518.374816252166, 51320.48679513232, 51847.48152518427, 52177.0, 52298.738506307986, 53022.73488632532, 48039.75980120077, 48307.5169248303, 48361.5163848364, 48487.757561212675, 49563.0, 9198.2181514572, 9322.207612353026, 9395.0, 9544.475053872104, 9583.377080489747, 35954.0, 37033.62966370302, 37214.25571488501, 37471.62528374681, 37544.43683344698, 44633.33050004317, 45963.0, 46468.0, 46561.301580477, 47706.761466192445, 11467.598634047768, 11474.4262786862, 12312.569060082855, 12392.876071239172, 12891.548795792101, 11730.296182229093, 11764.82352764692, 12015.098867584791, 12157.452914618687, 12673.239605623692, 11267.211295209258, 11470.483828227916, 11485.425728713699, 11780.0, 12077.214981026205, 11046.834297485704, 11302.547898083985, 11460.312381257152, 11865.762684746429, 12072.094592905743, 11485.540578377106, 11569.88430115688, 11606.419679016184, 12255.32595707209, 12426.254424734545, 9794.706158815246, 9984.700458986243, 10188.89811101909, 10396.324238924446, 10575.62985295511, 9757.756056098655, 9816.803663926825, 10141.188704903738, 10263.640772572924, 10332.53503592325], "unit": "ms", "name": "yui.html", "value": 6600.621790980702}], "name": "dromaeo_css", "value": 7333.961101896269}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 109.0, 110.0, 110.0, 99.0, 111.0, 111.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 136.0, 158.0, 162.0, 122.0, 144.0, 149.0, 126.0, 161.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 159.0, 162.0, 160.0, 159.0, 159.0, 160.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 71.0, 145.0, 72.0, 72.0, 71.0, 73.0, 156.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [98.0, 92.0, 135.0, 91.0, 92.0, 93.0, 141.0, 91.0, 92.0, 143.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 57.0, 56.0, 58.0, 56.0, 56.0, 57.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 70.0, 65.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 77.0, 77.0, 76.0, 86.0, 78.0, 77.0, 86.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 117.0, 111.0, 116.0, 115.0, 114.0, 119.0, 111.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.9}, {"lowerIsBetter": true, "replicates": [131.0, 140.0, 144.0, 139.0, 145.0, 131.0, 142.0, 141.0, 153.0, 129.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.5}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 66.0, 62.0, 65.0, 62.0, 64.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.8}], "name": "kraken", "value": 1473.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [164.74464579901152], "unit": "score", "name": "DeltaBlue", "value": 401.33626}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [957.8544061302682], "unit": "score", "name": "RayTrace", "value": 772.5485159999996}, {"lowerIsBetter": false, "replicates": [544.069640914037], "unit": "score", "name": "Earley", "value": 1224.9589940000005}, {"lowerIsBetter": false, "replicates": [10402.061855670103], "unit": "score", "name": "Boyer", "value": 64.07027849355795}, {"lowerIsBetter": false, "replicates": [24023.809523809523], "unit": "score", "name": "RegExp", "value": 37.920089197225}, {"lowerIsBetter": false, "replicates": [533.3333333333334], "unit": "score", "name": "Splay", "value": 152.795625}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23280.4458840497}]} 08:50:21 INFO - RETURN: dromaeo_css: 7333.96 08:50:21 INFO - RETURN: kraken: 1473.00 08:50:21 INFO - RETURN: v8_7: 23280.45 08:50:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23280.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1473.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7333.96"}}} 08:50:21 INFO - Return code: 0 08:50:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:50:22 INFO - # TBPL SUCCESS # 08:50:22 INFO - Running post-action listener: _resource_record_post_action 08:50:22 INFO - Running post-run listener: _resource_record_post_run 08:50:23 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 518590464; Read time: 0; Write time: 2714676 08:50:23 INFO - install - Wall time: 23s; CPU: 23.0%; Read bytes: 0; Write bytes: 254185472; Read time: 0; Write time: 1925708 08:50:23 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 253059072; Read time: 0; Write time: 657304 08:50:23 INFO - Running post-run listener: _upload_blobber_files 08:50:23 INFO - Blob upload gear active. 08:50:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:50:23 INFO - Copying logs to upload dir... 08:50:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.500355 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-19 08:50:22.687966) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-19 08:50:22.691253) ========= 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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010068 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455890340/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-19 08:50:22.743277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:50:22.743595) ========= 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=8783db0840cc980e80bb0bd400000236-1455899355.760747-687714529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 08:50:22.793559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 08:50:22.793949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 08:50:22.794302) ========= ========= Total master_lag: 0.26 =========