builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1454015593.09 results: success (0) buildid: 20160128104128 builduid: 477efa74258d4585a6c03d61f5886416 revision: 5e37eea7c669 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.086993) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.088472) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.089275) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006305 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.112457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.112730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.142318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.142572) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.194655) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.194910) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.195245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.195528) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-28 13:13:13-- 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% 219M=0s 2016-01-28 13:13:13 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.384194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.384484) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.048896 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.445394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:13.445709) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e37eea7c669 --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 5e37eea7c669 --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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-28 13:13:13,954 Setting DEBUG logging. 2016-01-28 13:13:13,955 attempt 1/10 2016-01-28 13:13:13,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e37eea7c669?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-28 13:13:14,409 unpacking tar archive at: mozilla-beta-5e37eea7c669/testing/mozharness/ program finished with exit code 0 elapsedTime=0.719620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:14.178570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:14.178868) ========= echo 5e37eea7c669 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e37eea7c669'] 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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5e37eea7c669 program finished with exit code 0 elapsedTime=0.004735 script_repo_revision: '5e37eea7c669' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:14.229049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:14.229332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 13:13:14.239358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-01-28 13:13:14.239621) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:13:14 INFO - MultiFileLogger online at 20160128 13:13:14 in /builds/slave/test-pgo 13:13:14 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 13:13:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:13:14 INFO - {'append_to_log': False, 13:13:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:13:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:13:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:13:14 INFO - 'branch': 'Mozilla-Beta', 13:13:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:13:14 INFO - 'config_files': ('talos/linux_config.py',), 13:13:14 INFO - 'default_actions': ('clobber', 13:13:14 INFO - 'read-buildbot-config', 13:13:14 INFO - 'download-and-extract', 13:13:14 INFO - 'populate-webroot', 13:13:14 INFO - 'create-virtualenv', 13:13:14 INFO - 'install', 13:13:14 INFO - 'run-tests'), 13:13:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:13:14 INFO - 'download_minidump_stackwalk': True, 13:13:14 INFO - 'download_symbols': 'ondemand', 13:13:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:13:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:13:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:13:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:13:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:13:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:13:14 INFO - 'installer_path': 'installer.exe', 13:13:14 INFO - 'log_level': 'info', 13:13:14 INFO - 'log_name': 'talos', 13:13:14 INFO - 'log_to_console': True, 13:13:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:13:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:13:14 INFO - 'opt_config_files': (), 13:13:14 INFO - 'pip_index': False, 13:13:14 INFO - 'sps_profile': False, 13:13:14 INFO - 'sps_profile_interval': 0, 13:13:14 INFO - 'suite': 'dromaeojs', 13:13:14 INFO - 'system_bits': '32', 13:13:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:13:14 INFO - 'title': 'talos-linux64-ix-042', 13:13:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:13:14 INFO - 'use_talos_json': True, 13:13:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:13:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:13:14 INFO - 'work_dir': 'build'} 13:13:14 INFO - ##### 13:13:14 INFO - ##### Running clobber step. 13:13:14 INFO - ##### 13:13:14 INFO - Running pre-action listener: _resource_record_pre_action 13:13:14 INFO - Running main action method: clobber 13:13:14 INFO - rmtree: /builds/slave/test-pgo/build 13:13:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:13:15 INFO - Running post-action listener: _resource_record_post_action 13:13:15 INFO - ##### 13:13:15 INFO - ##### Running read-buildbot-config step. 13:13:15 INFO - ##### 13:13:15 INFO - Running pre-action listener: _resource_record_pre_action 13:13:15 INFO - Running main action method: read_buildbot_config 13:13:15 INFO - Using buildbot properties: 13:13:15 INFO - { 13:13:15 INFO - "properties": { 13:13:15 INFO - "buildnumber": 92, 13:13:15 INFO - "product": "firefox", 13:13:15 INFO - "script_repo_revision": "production", 13:13:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:13:15 INFO - "repository": "", 13:13:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:13:15 INFO - "buildid": "20160128104128", 13:13:15 INFO - "slavename": "talos-linux64-ix-042", 13:13:15 INFO - "pgo_build": "True", 13:13:15 INFO - "basedir": "/builds/slave/test-pgo", 13:13:15 INFO - "project": "", 13:13:15 INFO - "platform": "ubuntu64_hw", 13:13:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:13:15 INFO - "slavebuilddir": "test", 13:13:15 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:13:15 INFO - "branch": "mozilla-beta", 13:13:15 INFO - "repo_path": "releases/mozilla-beta", 13:13:15 INFO - "stage_platform": "linux64-pgo", 13:13:15 INFO - "builduid": "477efa74258d4585a6c03d61f5886416", 13:13:15 INFO - "revision": "5e37eea7c669" 13:13:15 INFO - }, 13:13:15 INFO - "sourcestamp": { 13:13:15 INFO - "repository": "", 13:13:15 INFO - "hasPatch": false, 13:13:15 INFO - "project": "", 13:13:15 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:13:15 INFO - "changes": [ 13:13:15 INFO - { 13:13:15 INFO - "category": null, 13:13:15 INFO - "files": [ 13:13:15 INFO - { 13:13:15 INFO - "url": null, 13:13:15 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.tar.bz2" 13:13:15 INFO - } 13:13:15 INFO - ], 13:13:15 INFO - "repository": "", 13:13:15 INFO - "rev": "5e37eea7c669", 13:13:15 INFO - "who": "sendchange", 13:13:15 INFO - "when": 1454015555, 13:13:15 INFO - "number": 7531254, 13:13:15 INFO - "comments": "Bug 1232258 - Fix _Learn More_ link in aboutCertError.xhtml and aboutNetError.xhtml r=past a=sylvestre", 13:13:15 INFO - "project": "", 13:13:15 INFO - "at": "Thu 28 Jan 2016 13:12:35", 13:13:15 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:13:15 INFO - "revlink": "", 13:13:15 INFO - "properties": [ 13:13:15 INFO - [ 13:13:15 INFO - "buildid", 13:13:15 INFO - "20160128104128", 13:13:15 INFO - "Change" 13:13:15 INFO - ], 13:13:15 INFO - [ 13:13:15 INFO - "builduid", 13:13:15 INFO - "477efa74258d4585a6c03d61f5886416", 13:13:15 INFO - "Change" 13:13:15 INFO - ], 13:13:15 INFO - [ 13:13:15 INFO - "pgo_build", 13:13:15 INFO - "True", 13:13:15 INFO - "Change" 13:13:15 INFO - ] 13:13:15 INFO - ], 13:13:15 INFO - "revision": "5e37eea7c669" 13:13:15 INFO - } 13:13:15 INFO - ], 13:13:15 INFO - "revision": "5e37eea7c669" 13:13:15 INFO - } 13:13:15 INFO - } 13:13:15 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.tar.bz2. 13:13:15 INFO - Running post-action listener: _resource_record_post_action 13:13:15 INFO - ##### 13:13:15 INFO - ##### Running download-and-extract step. 13:13:15 INFO - ##### 13:13:15 INFO - Running pre-action listener: _resource_record_pre_action 13:13:15 INFO - Running main action method: download_and_extract 13:13:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/test_packages.json 13:13:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:13:15 INFO - Downloaded 1270 bytes. 13:13:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:13:15 INFO - Using the following test package requirements: 13:13:15 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:13:15 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:13:15 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:13:15 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:13:15 INFO - u'jsshell-linux-x86_64.zip'], 13:13:15 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:13:15 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:13:15 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:13:15 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:13:15 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 13:13:15 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:13:15 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 13:13:15 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:13:15 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:13:15 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:13:15 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:13:15 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:13:15 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:13:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:16 INFO - Downloaded 21581608 bytes. 13:13:16 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 13:13:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:13:16 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 13:13:17 INFO - Return code: 0 13:13:17 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 13:13:17 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')]} 13:13:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:13:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:17 INFO - Downloaded 21581608 bytes. 13:13:17 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 13:13:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:13:17 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 13:13:19 INFO - Return code: 0 13:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:19 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:13:19 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:21 INFO - Downloaded 11132038 bytes. 13:13:21 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 13:13:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:13:21 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 13:13:22 INFO - Return code: 0 13:13: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')]} 13:13:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:13:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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 13:13:22 INFO - Downloaded 57947927 bytes. 13:13:22 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:13:22 INFO - mkdir: /builds/slave/test-pgo/properties 13:13:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:13:22 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:13:22 INFO - Contents: 13:13:22 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:13:22 INFO - Running post-action listener: _resource_record_post_action 13:13:22 INFO - Running post-action listener: set_extra_try_arguments 13:13:22 INFO - ##### 13:13:22 INFO - ##### Running populate-webroot step. 13:13:22 INFO - ##### 13:13:22 INFO - Running pre-action listener: _resource_record_pre_action 13:13:22 INFO - Running main action method: populate_webroot 13:13:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:13:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:13:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:13:22 INFO - '--tppagecycles', 13:13:22 INFO - '7'], 13:13:22 INFO - 'tests': ['tsvgm']}}, 13:13:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:13:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:13:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:13:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:13:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:22 INFO - 'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:22 INFO - 'tests': ['damp', 'tps']}, 13:13:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:22 INFO - 'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['damp', 'tps']}, 13:13:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:13:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:13:22 INFO - 'other': {'tests': ['a11yr', 13:13:22 INFO - 'ts_paint', 13:13:22 INFO - 'tpaint', 13:13:22 INFO - 'sessionrestore', 13:13:22 INFO - 'sessionrestore_no_auto_restore']}, 13:13:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['a11yr', 13:13:22 INFO - 'ts_paint', 13:13:22 INFO - 'tpaint', 13:13:22 INFO - 'sessionrestore', 13:13:22 INFO - 'sessionrestore_no_auto_restore']}, 13:13:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['a11yr', 13:13:22 INFO - 'ts_paint', 13:13:22 INFO - 'tpaint', 13:13:22 INFO - 'sessionrestore', 13:13:22 INFO - 'sessionrestore_no_auto_restore']}, 13:13:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['a11yr', 13:13:22 INFO - 'ts_paint', 13:13:22 INFO - 'tpaint', 13:13:22 INFO - 'sessionrestore', 13:13:22 INFO - 'sessionrestore_no_auto_restore']}, 13:13:22 INFO - 'other_l64': {'tests': ['a11yr', 13:13:22 INFO - 'ts_paint', 13:13:22 INFO - 'tpaint', 13:13:22 INFO - 'sessionrestore', 13:13:22 INFO - 'sessionrestore_no_auto_restore']}, 13:13:22 INFO - 'other_nol64': {'tests': ['a11yr', 13:13:22 INFO - 'ts_paint', 13:13:22 INFO - 'tpaint', 13:13:22 INFO - 'sessionrestore', 13:13:22 INFO - 'sessionrestore_no_auto_restore']}, 13:13:22 INFO - 'svgr': {'tests': ['tsvgx', 13:13:22 INFO - 'tsvgr_opacity', 13:13:22 INFO - 'tart', 13:13:22 INFO - 'tscrollx', 13:13:22 INFO - 'cart']}, 13:13:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['tsvgx', 13:13:22 INFO - 'tsvgr_opacity', 13:13:22 INFO - 'tart', 13:13:22 INFO - 'tscrollx', 13:13:22 INFO - 'cart']}, 13:13:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:22 INFO - 'tests': ['tp5o']}, 13:13:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:22 INFO - 'talos_options': ['--e10s'], 13:13:22 INFO - 'tests': ['tp5o']}, 13:13:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:22 INFO - 'talos_options': ['--xperf_path', 13:13:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:22 INFO - 'tests': ['tp5n']}, 13:13:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:23 INFO - 'talos_options': ['--e10s', 13:13:23 INFO - '--xperf_path', 13:13:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:23 INFO - 'tests': ['tp5n']}}, 13:13:23 INFO - 'talos.zip': {'path': '', 13:13:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:13:23 INFO - Running post-action listener: _resource_record_post_action 13:13:23 INFO - ##### 13:13:23 INFO - ##### Running create-virtualenv step. 13:13:23 INFO - ##### 13:13:23 INFO - Running pre-action listener: _resource_record_pre_action 13:13:23 INFO - Running main action method: create_virtualenv 13:13:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:13: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 13:13:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:13:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:13:23 INFO - Using real prefix '/usr' 13:13:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:13:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:13:25 INFO - Installing pip.................done. 13:13:25 INFO - Return code: 0 13:13:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:13:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:13:25 INFO - Using env: {'DISPLAY': ':0', 13:13:25 INFO - 'HOME': '/home/cltbld', 13:13:25 INFO - 'LANG': 'en_US.UTF-8', 13:13:25 INFO - 'LANGUAGE': 'en_US:en', 13:13:25 INFO - 'LOGNAME': 'cltbld', 13:13:25 INFO - 'MAIL': '/var/mail/cltbld', 13:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:25 INFO - 'MOZ_NO_REMOTE': '1', 13:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:25 INFO - 'NO_EM_RESTART': '1', 13:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:25 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:25 INFO - 'SHELL': '/bin/bash', 13:13:25 INFO - 'SHLVL': '1', 13:13:25 INFO - 'TERM': 'linux', 13:13:25 INFO - 'TMOUT': '86400', 13:13:25 INFO - 'USER': 'cltbld', 13:13:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:25 INFO - '_': '/tools/buildbot/bin/python'} 13:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:25 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 13:13:25 INFO - Cleaning up... 13:13:25 INFO - Return code: 0 13:13:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:13:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:13:25 INFO - Using env: {'DISPLAY': ':0', 13:13:25 INFO - 'HOME': '/home/cltbld', 13:13:25 INFO - 'LANG': 'en_US.UTF-8', 13:13:25 INFO - 'LANGUAGE': 'en_US:en', 13:13:25 INFO - 'LOGNAME': 'cltbld', 13:13:25 INFO - 'MAIL': '/var/mail/cltbld', 13:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:25 INFO - 'MOZ_NO_REMOTE': '1', 13:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:25 INFO - 'NO_EM_RESTART': '1', 13:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:25 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:25 INFO - 'SHELL': '/bin/bash', 13:13:25 INFO - 'SHLVL': '1', 13:13:25 INFO - 'TERM': 'linux', 13:13:25 INFO - 'TMOUT': '86400', 13:13:25 INFO - 'USER': 'cltbld', 13:13:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:25 INFO - '_': '/tools/buildbot/bin/python'} 13:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:26 INFO - Downloading/unpacking psutil>=0.7.1 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:13:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:27 INFO - Installing collected packages: psutil 13:13:27 INFO - Running setup.py install for psutil 13:13:27 INFO - building 'psutil._psutil_linux' extension 13:13:27 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 13:13:28 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 13:13:28 INFO - building 'psutil._psutil_posix' extension 13:13:28 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 13:13:28 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 13:13:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:28 INFO - Successfully installed psutil 13:13:28 INFO - Cleaning up... 13:13:28 INFO - Return code: 0 13:13:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:28 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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:28 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 13:13:28 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 13:13:28 INFO - Using env: {'DISPLAY': ':0', 13:13:28 INFO - 'HOME': '/home/cltbld', 13:13:28 INFO - 'LANG': 'en_US.UTF-8', 13:13:28 INFO - 'LANGUAGE': 'en_US:en', 13:13:28 INFO - 'LOGNAME': 'cltbld', 13:13:28 INFO - 'MAIL': '/var/mail/cltbld', 13:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:28 INFO - 'MOZ_NO_REMOTE': '1', 13:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:28 INFO - 'NO_EM_RESTART': '1', 13:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:28 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:28 INFO - 'SHELL': '/bin/bash', 13:13:28 INFO - 'SHLVL': '1', 13:13:28 INFO - 'TERM': 'linux', 13:13:28 INFO - 'TMOUT': '86400', 13:13:28 INFO - 'USER': 'cltbld', 13:13:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:28 INFO - '_': '/tools/buildbot/bin/python'} 13:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:13:28 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 13:13:28 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 13:13:28 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 13:13:28 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 13:13:28 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 13:13:28 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 13:13:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:13:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:13:30 INFO - Installing collected packages: mozsystemmonitor 13:13:30 INFO - Running setup.py install for mozsystemmonitor 13:13:30 INFO - Successfully installed mozsystemmonitor 13:13:30 INFO - Cleaning up... 13:13:30 INFO - Return code: 0 13:13:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:30 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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:30 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 13:13:30 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 13:13:30 INFO - Using env: {'DISPLAY': ':0', 13:13:30 INFO - 'HOME': '/home/cltbld', 13:13:30 INFO - 'LANG': 'en_US.UTF-8', 13:13:30 INFO - 'LANGUAGE': 'en_US:en', 13:13:30 INFO - 'LOGNAME': 'cltbld', 13:13:30 INFO - 'MAIL': '/var/mail/cltbld', 13:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:30 INFO - 'MOZ_NO_REMOTE': '1', 13:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:30 INFO - 'NO_EM_RESTART': '1', 13:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:30 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:30 INFO - 'SHELL': '/bin/bash', 13:13:30 INFO - 'SHLVL': '1', 13:13:30 INFO - 'TERM': 'linux', 13:13:30 INFO - 'TMOUT': '86400', 13:13:30 INFO - 'USER': 'cltbld', 13:13:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:30 INFO - '_': '/tools/buildbot/bin/python'} 13:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:13:30 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 13:13:30 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 13:13:30 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 13:13:30 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 13:13:30 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 13:13:30 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 13:13:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:13:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:13:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:13:32 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 13:13:32 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 13:13:32 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 13:13:32 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 13:13:32 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 13:13:32 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 13:13:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:13:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13:33 INFO - Downloading docopt-0.6.1.tar.gz 13:13:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:13:33 INFO - Installing collected packages: blobuploader, requests, docopt 13:13:33 INFO - Running setup.py install for blobuploader 13:13:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:13:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:13:33 INFO - Running setup.py install for requests 13:13:33 INFO - Running setup.py install for docopt 13:13:33 INFO - Successfully installed blobuploader requests docopt 13:13:33 INFO - Cleaning up... 13:13:33 INFO - Return code: 0 13:13:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:13:33 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')]} 13:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:33 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')]} 13:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:33 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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:33 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 13:13:33 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 13:13:33 INFO - Using env: {'DISPLAY': ':0', 13:13:33 INFO - 'HOME': '/home/cltbld', 13:13:33 INFO - 'LANG': 'en_US.UTF-8', 13:13:33 INFO - 'LANGUAGE': 'en_US:en', 13:13:33 INFO - 'LOGNAME': 'cltbld', 13:13:33 INFO - 'MAIL': '/var/mail/cltbld', 13:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:33 INFO - 'MOZ_NO_REMOTE': '1', 13:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:33 INFO - 'NO_EM_RESTART': '1', 13:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:33 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:33 INFO - 'SHELL': '/bin/bash', 13:13:33 INFO - 'SHLVL': '1', 13:13:33 INFO - 'TERM': 'linux', 13:13:33 INFO - 'TMOUT': '86400', 13:13:33 INFO - 'USER': 'cltbld', 13:13:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:33 INFO - '_': '/tools/buildbot/bin/python'} 13:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:13:34 INFO - Running setup.py (path:/tmp/pip-6Q3Br6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:13:34 INFO - Running setup.py (path:/tmp/pip-D3ubuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:13:34 INFO - Running setup.py (path:/tmp/pip-ajZz8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:13:34 INFO - Running setup.py (path:/tmp/pip-XUu_99-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:13:34 INFO - Running setup.py (path:/tmp/pip-wbog6i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:13:34 INFO - Running setup.py (path:/tmp/pip-rF0Ci6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:13:34 INFO - Running setup.py (path:/tmp/pip-uGKIld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:13:34 INFO - Running setup.py (path:/tmp/pip-8ZqvIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:13:34 INFO - Running setup.py (path:/tmp/pip-kfh2BB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:13:34 INFO - Running setup.py (path:/tmp/pip-B4dage-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:13:34 INFO - Running setup.py (path:/tmp/pip-tF_J0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:13:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:13:34 INFO - Running setup.py (path:/tmp/pip-bEY_K6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:13:35 INFO - Running setup.py (path:/tmp/pip-0pTNXV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:13:35 INFO - Running setup.py (path:/tmp/pip-WY4pXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:13:35 INFO - Running setup.py (path:/tmp/pip-JlwMNd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:13:35 INFO - Running setup.py (path:/tmp/pip-OS5W43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:13:35 INFO - Running setup.py (path:/tmp/pip-uhx7jD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:13:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:13:35 INFO - Running setup.py install for manifestparser 13:13:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:13:35 INFO - Running setup.py install for mozcrash 13:13:35 INFO - Running setup.py install for mozdebug 13:13:35 INFO - Running setup.py install for mozdevice 13:13:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:13:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:13:35 INFO - Running setup.py install for mozfile 13:13:35 INFO - Running setup.py install for mozhttpd 13:13:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:13:35 INFO - Running setup.py install for mozinfo 13:13:36 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Running setup.py install for mozInstall 13:13:36 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Running setup.py install for mozleak 13:13:36 INFO - Running setup.py install for mozlog 13:13:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Running setup.py install for moznetwork 13:13:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Running setup.py install for mozprocess 13:13:36 INFO - Running setup.py install for mozprofile 13:13:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Running setup.py install for mozrunner 13:13:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:13:36 INFO - Running setup.py install for mozscreenshot 13:13:36 INFO - Running setup.py install for moztest 13:13:37 INFO - Running setup.py install for mozversion 13:13:37 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:13:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:13:37 INFO - Cleaning up... 13:13:37 INFO - Return code: 0 13:13:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:37 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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:37 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 13:13:37 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 13:13:37 INFO - Using env: {'DISPLAY': ':0', 13:13:37 INFO - 'HOME': '/home/cltbld', 13:13:37 INFO - 'LANG': 'en_US.UTF-8', 13:13:37 INFO - 'LANGUAGE': 'en_US:en', 13:13:37 INFO - 'LOGNAME': 'cltbld', 13:13:37 INFO - 'MAIL': '/var/mail/cltbld', 13:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:37 INFO - 'MOZ_NO_REMOTE': '1', 13:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:37 INFO - 'NO_EM_RESTART': '1', 13:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:37 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:37 INFO - 'SHELL': '/bin/bash', 13:13:37 INFO - 'SHLVL': '1', 13:13:37 INFO - 'TERM': 'linux', 13:13:37 INFO - 'TMOUT': '86400', 13:13:37 INFO - 'USER': 'cltbld', 13:13:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:37 INFO - '_': '/tools/buildbot/bin/python'} 13:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:13:37 INFO - Running setup.py (path:/tmp/pip-U5Lxlg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:13:37 INFO - Running setup.py (path:/tmp/pip-SR8Ewi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:13:37 INFO - Running setup.py (path:/tmp/pip-SEHFaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:13:37 INFO - Running setup.py (path:/tmp/pip-P36h1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:13:37 INFO - Running setup.py (path:/tmp/pip-cA0WcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:13:37 INFO - Running setup.py (path:/tmp/pip-epVCd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:13:37 INFO - Running setup.py (path:/tmp/pip-Ck6p6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:13:37 INFO - Running setup.py (path:/tmp/pip-GAmMC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:13:37 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)) 13:13:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:13:37 INFO - Running setup.py (path:/tmp/pip-blDkP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:13:38 INFO - Running setup.py (path:/tmp/pip-QCpbEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:13:38 INFO - Running setup.py (path:/tmp/pip-jBw_Aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:13:38 INFO - Running setup.py (path:/tmp/pip-STxTrT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:13:38 INFO - Running setup.py (path:/tmp/pip-XsMvUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:13:38 INFO - Running setup.py (path:/tmp/pip-9H7KZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:13:38 INFO - Running setup.py (path:/tmp/pip-WcsoPO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:13:38 INFO - Running setup.py (path:/tmp/pip-liwRO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:13:38 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)) 13:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:13:38 INFO - Running setup.py (path:/tmp/pip-ioJcKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:13:38 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)) 13:13:38 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)) 13:13:38 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)) 13:13:38 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)) 13:13:38 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)) 13:13:38 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)) 13:13:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:13:38 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 13:13:38 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 13:13:38 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 13:13:38 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 13:13:38 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 13:13:38 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 13:13:40 INFO - Downloading blessings-1.6.tar.gz 13:13:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:13:40 INFO - Installing collected packages: blessings 13:13:40 INFO - Running setup.py install for blessings 13:13:40 INFO - Successfully installed blessings 13:13:40 INFO - Cleaning up... 13:13:40 INFO - Return code: 0 13:13:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:13:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:13:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:13:40 INFO - Reading from file tmpfile_stdout 13:13:40 INFO - Current package versions: 13:13:40 INFO - argparse == 1.2.1 13:13:40 INFO - blessings == 1.6 13:13:40 INFO - blobuploader == 1.2.4 13:13:40 INFO - docopt == 0.6.1 13:13:40 INFO - manifestparser == 1.1 13:13:40 INFO - mozInstall == 1.12 13:13:40 INFO - mozcrash == 0.16 13:13:40 INFO - mozdebug == 0.1 13:13:40 INFO - mozdevice == 0.47 13:13:40 INFO - mozfile == 1.2 13:13:40 INFO - mozhttpd == 0.7 13:13:40 INFO - mozinfo == 0.9 13:13:40 INFO - mozleak == 0.1 13:13:40 INFO - mozlog == 3.1 13:13:40 INFO - moznetwork == 0.27 13:13:40 INFO - mozprocess == 0.22 13:13:40 INFO - mozprofile == 0.27 13:13:40 INFO - mozrunner == 6.11 13:13:40 INFO - mozscreenshot == 0.1 13:13:40 INFO - mozsystemmonitor == 0.0 13:13:40 INFO - moztest == 0.7 13:13:40 INFO - mozversion == 1.4 13:13:40 INFO - psutil == 3.1.1 13:13:40 INFO - requests == 1.2.3 13:13:40 INFO - wsgiref == 0.1.2 13:13:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:13:40 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')]} 13:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:40 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')]} 13:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:40 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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:40 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 13:13:40 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 13:13:40 INFO - Using env: {'DISPLAY': ':0', 13:13:40 INFO - 'HOME': '/home/cltbld', 13:13:40 INFO - 'LANG': 'en_US.UTF-8', 13:13:40 INFO - 'LANGUAGE': 'en_US:en', 13:13:40 INFO - 'LOGNAME': 'cltbld', 13:13:40 INFO - 'MAIL': '/var/mail/cltbld', 13:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:40 INFO - 'MOZ_NO_REMOTE': '1', 13:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:40 INFO - 'NO_EM_RESTART': '1', 13:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:40 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:40 INFO - 'SHELL': '/bin/bash', 13:13:40 INFO - 'SHLVL': '1', 13:13:40 INFO - 'TERM': 'linux', 13:13:40 INFO - 'TMOUT': '86400', 13:13:40 INFO - 'USER': 'cltbld', 13:13:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:40 INFO - '_': '/tools/buildbot/bin/python'} 13:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 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)) 13:13:41 INFO - Cleaning up... 13:13:41 INFO - Return code: 0 13:13:41 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:13:41 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')]} 13:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:41 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')]} 13:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:41 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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:41 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 13:13:41 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 13:13:41 INFO - Using env: {'DISPLAY': ':0', 13:13:41 INFO - 'HOME': '/home/cltbld', 13:13:41 INFO - 'LANG': 'en_US.UTF-8', 13:13:41 INFO - 'LANGUAGE': 'en_US:en', 13:13:41 INFO - 'LOGNAME': 'cltbld', 13:13:41 INFO - 'MAIL': '/var/mail/cltbld', 13:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:41 INFO - 'MOZ_NO_REMOTE': '1', 13:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:41 INFO - 'NO_EM_RESTART': '1', 13:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:41 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:41 INFO - 'SHELL': '/bin/bash', 13:13:41 INFO - 'SHLVL': '1', 13:13:41 INFO - 'TERM': 'linux', 13:13:41 INFO - 'TMOUT': '86400', 13:13:41 INFO - 'USER': 'cltbld', 13:13:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:41 INFO - '_': '/tools/buildbot/bin/python'} 13:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:41 INFO - Downloading/unpacking jsonschema 13:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:13:43 INFO - Downloading/unpacking functools32 (from jsonschema) 13:13:43 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 13:13:43 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 13:13:43 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 13:13:43 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 13:13:43 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 13:13:43 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 13:13:43 INFO - Downloading functools32-3.2.3-2.tar.gz 13:13:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:13:43 INFO - warning: no files found matching '*.txt' 13:13:43 INFO - no previously-included directories found matching 'build' 13:13:43 INFO - no previously-included directories found matching 'dist' 13:13:43 INFO - no previously-included directories found matching '.git*' 13:13:43 INFO - Installing collected packages: jsonschema, functools32 13:13:43 INFO - Running setup.py install for functools32 13:13:43 INFO - warning: no files found matching '*.txt' 13:13:43 INFO - no previously-included directories found matching 'build' 13:13:43 INFO - no previously-included directories found matching 'dist' 13:13:43 INFO - no previously-included directories found matching '.git*' 13:13:43 INFO - Successfully installed jsonschema functools32 13:13:43 INFO - Cleaning up... 13:13:43 INFO - Return code: 0 13:13:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:13:43 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')]} 13:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:43 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')]} 13:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:43 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 0x7f3e7cdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25da600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', '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 13:13:43 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 13:13:43 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 13:13:43 INFO - Using env: {'DISPLAY': ':0', 13:13:43 INFO - 'HOME': '/home/cltbld', 13:13:43 INFO - 'LANG': 'en_US.UTF-8', 13:13:43 INFO - 'LANGUAGE': 'en_US:en', 13:13:43 INFO - 'LOGNAME': 'cltbld', 13:13:43 INFO - 'MAIL': '/var/mail/cltbld', 13:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:43 INFO - 'MOZ_NO_REMOTE': '1', 13:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:43 INFO - 'NO_EM_RESTART': '1', 13:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:13:43 INFO - 'PWD': '/builds/slave/test-pgo', 13:13:43 INFO - 'SHELL': '/bin/bash', 13:13:43 INFO - 'SHLVL': '1', 13:13:43 INFO - 'TERM': 'linux', 13:13:43 INFO - 'TMOUT': '86400', 13:13:43 INFO - 'USER': 'cltbld', 13:13:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:43 INFO - '_': '/tools/buildbot/bin/python'} 13:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:43 INFO - Downloading/unpacking flake8 13:13:43 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 13:13:43 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 13:13:43 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 13:13:43 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 13:13:43 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 13:13:43 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 13:13:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:13:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:13:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:13:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:13:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:13:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:13:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:13:46 INFO - no previously-included directories found matching 'docs/_build' 13:13:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:13:46 INFO - Running setup.py install for pep8 13:13:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:13:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:13:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:13:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:13:46 INFO - no previously-included directories found matching 'docs/_build' 13:13:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:13:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:13:46 INFO - Cleaning up... 13:13:46 INFO - Return code: 0 13:13:46 INFO - Running post-action listener: _resource_record_post_action 13:13:46 INFO - Running post-action listener: _start_resource_monitoring 13:13:46 INFO - Starting resource monitoring. 13:13:46 INFO - ##### 13:13:46 INFO - ##### Running install step. 13:13:46 INFO - ##### 13:13:46 INFO - Running pre-action listener: _resource_record_pre_action 13:13:46 INFO - Running main action method: install 13:13:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:13:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:13:46 INFO - Reading from file tmpfile_stdout 13:13:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:13:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:13:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:13:46 INFO - Reading from file tmpfile_stdout 13:13:46 INFO - Output received: 13:13:46 INFO - Usage: mozinstall [options] installer 13:13:46 INFO - Options: 13:13:46 INFO - -h, --help show this help message and exit 13:13:46 INFO - -d DEST, --destination=DEST 13:13:46 INFO - Directory to install application into. [default: 13:13:46 INFO - "/builds/slave/test-pgo"] 13:13:46 INFO - --app=APP Application being installed. [default: firefox] 13:13:46 INFO - mkdir: /builds/slave/test-pgo/build/application 13:13:46 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'] 13:13:46 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 13:14:01 INFO - Reading from file tmpfile_stdout 13:14:01 INFO - Output received: 13:14:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:14:01 INFO - Running post-action listener: _resource_record_post_action 13:14:01 INFO - ##### 13:14:01 INFO - ##### Running run-tests step. 13:14:01 INFO - ##### 13:14:01 INFO - Running pre-action listener: _resource_record_pre_action 13:14:01 INFO - Running main action method: run_tests 13:14:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:14:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:14:01 INFO - Python 2.7.3 13:14:01 INFO - Return code: 0 13:14:01 INFO - grabbing minidump binary from tooltool 13:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:01 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 0x2669350>, '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 0x266a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x266a6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:14:01 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 13:14:01 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 13:14:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:14:01 INFO - Return code: 0 13:14:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:14:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:14:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:14:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:14:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:14:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:14:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:14:02 INFO - Return code: 0 13:14:02 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/1454006488/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:14:02 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/1454006488/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 13:14:02 INFO - Using env: {'DISPLAY': ':0', 13:14:02 INFO - 'HOME': '/home/cltbld', 13:14:02 INFO - 'LANG': 'en_US.UTF-8', 13:14:02 INFO - 'LANGUAGE': 'en_US:en', 13:14:02 INFO - 'LOGNAME': 'cltbld', 13:14:02 INFO - 'MAIL': '/var/mail/cltbld', 13:14:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:14:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:02 INFO - 'MOZ_NO_REMOTE': '1', 13:14:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:02 INFO - 'NO_EM_RESTART': '1', 13:14:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:14:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:14:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:14:02 INFO - 'SHELL': '/bin/bash', 13:14:02 INFO - 'SHLVL': '1', 13:14:02 INFO - 'TERM': 'linux', 13:14:02 INFO - 'TMOUT': '86400', 13:14:02 INFO - 'USER': 'cltbld', 13:14:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275', 13:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:02 INFO - '_': '/tools/buildbot/bin/python'} 13:14:02 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/1454006488/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 13:14:02 INFO - mozversion INFO | application_buildid: 20160128104128 13:14:02 INFO - mozversion INFO | application_changeset: 5e37eea7c669c1b06ea8d280bae4a2eaee82c53a 13:14:02 INFO - mozversion INFO | application_display_name: Nightly 13:14:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:14:02 INFO - mozversion INFO | application_name: Firefox 13:14:02 INFO - mozversion INFO | application_remotingname: firefox 13:14:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:14:02 INFO - mozversion INFO | application_vendor: Mozilla 13:14:02 INFO - mozversion INFO | application_version: 45.0 13:14:02 INFO - mozversion INFO | platform_buildid: 20160128104128 13:14:02 INFO - mozversion INFO | platform_changeset: 5e37eea7c669c1b06ea8d280bae4a2eaee82c53a 13:14:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:14:02 INFO - mozversion INFO | platform_version: 45.0 13:14:02 INFO - 2016-01-28 13:14:02,763 DEBUG : using testdate: 1454015642 13:14:02 INFO - 2016-01-28 13:14:02,763 DEBUG : actual date: 1454015642 13:14:02 INFO - 2016-01-28 13:14:02,771 INFO : starting webserver on 'localhost:49080' 13:14:02 INFO - 2016-01-28 13:14:02,772 INFO : Starting test suite talos-linux64-ix-042 13:14:02 INFO - 2016-01-28 13:14:02,773 INFO : Starting test dromaeo_css 13:14:02 INFO - 2016-01-28 13:14:02,773 DEBUG : operating with platform_type : linux_ 13:14:02 INFO - 2016-01-28 13:14:02,773 INFO : Initialising browser for dromaeo_css test... 13:14:02 INFO - 2016-01-28 13:14:02,788 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpjnZa/profile http://localhost:49080/getInfo.html 13:14:06 INFO - 2016-01-28 13:14:06,875 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:14:06 INFO - 2016-01-28 13:14:06,876 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:14:06 INFO - 2016-01-28 13:14:06,876 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:14:06 INFO - 2016-01-28 13:14:06,876 DEBUG : BROWSER_OUTPUT: __metrics 13:14:06 INFO - 2016-01-28 13:14:06,998 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:14:07 INFO - 2016-01-28 13:14:07,709 INFO : Browser initialized. 13:14:07 INFO - 2016-01-28 13:14:07,710 INFO : Running cycle 1/1 for dromaeo_css test... 13:14:07 INFO - 2016-01-28 13:14:07,710 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpjnZa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:14:19 INFO - 2016-01-28 13:14:19,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 134025216 13:14:19 INFO - 2016-01-28 13:14:19,495 DEBUG : BROWSER_OUTPUT: 13:15:10 INFO - 2016-01-28 13:15:10,318 DEBUG : BROWSER_OUTPUT: 1454015710317 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] 13:17:18 INFO - 2016-01-28 13:17:18,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49080/tests/dromaeo/cssquery-ext.html) 13:17:19 INFO - 2016-01-28 13:17:19,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 225792000 13:17:19 INFO - 2016-01-28 13:17:19,586 DEBUG : BROWSER_OUTPUT: 13:20:21 INFO - 2016-01-28 13:20:21,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/dromaeo/cssquery-ext.html (next: http://localhost:49080/tests/dromaeo/cssquery-jquery.html) 13:20:22 INFO - 2016-01-28 13:20:22,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 219717632 13:20:22 INFO - 2016-01-28 13:20:22,181 DEBUG : BROWSER_OUTPUT: 13:23:23 INFO - 2016-01-28 13:23:23,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49080/tests/dromaeo/cssquery-mootools.html) 13:23:24 INFO - 2016-01-28 13:23:24,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 220655616 13:23:24 INFO - 2016-01-28 13:23:24,470 DEBUG : BROWSER_OUTPUT: 13:26:26 INFO - 2016-01-28 13:26:26,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49080/tests/dromaeo/cssquery-prototype.html) 13:26:26 INFO - 2016-01-28 13:26:26,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 199790592 13:26:26 INFO - 2016-01-28 13:26:26,732 DEBUG : BROWSER_OUTPUT: 13:29:29 INFO - 2016-01-28 13:29:29,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49080/tests/dromaeo/cssquery-yui.html) 13:29:29 INFO - 2016-01-28 13:29:29,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 198381568 13:29:29 INFO - 2016-01-28 13:29:29,682 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/dromaeo/cssquery-yui.html (next: http://localhost:49080/tests/dromaeo/cssquery-dojo.html) 13:32:31 INFO - 2016-01-28 13:32:31,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 240844800 13:32:31 INFO - 2016-01-28 13:32:31,962 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,962 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:32:31 INFO - 2016-01-28 13:32:31,963 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:32:31 INFO - 2016-01-28 13:32:31,963 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:32:31 INFO - 2016-01-28 13:32:31,963 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:32:31 INFO - 2016-01-28 13:32:31,964 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3253.333066721322;3360.277540328832;3367.696907278346;3377.5778027746533;3404.5233667286575;5439.18412238164;5613.635113717605;5625.887482250358;5628.943710562899;5643.814798892237;5569.554435645138;5642.379338272797;5642.746076426561;5659.915101273474;5664.178694089354;4980.701157930535;5012.097822391968;5084.77118529667;5139.511746384106;5187.273781670569;5140.203268493389;5145.970805838847;5155.484451554852;5157.76790044447;5165.1219292720325;5062.772175252123;5068.46781087986;5092.210707340369;5143.228515722652;5153.665011774241;5187.792488300463;5217.973910130425;5227.18978558324;5231.921521177204;5231.9476805232225;5160.8193713220235;5188.948110518884;5213.635045546814;5272.472752724697;5289.497497737709;5279.472052794728;5321.866953326159;5415.808522125126;5419.512243898029;5428.240046393508;6106.3893610639025;6123.571350005502;6162.383761623802;6162.907556386658;6163.445289923883;5777.62445441045;6158.907616385713;6202.658853763086;6205.379462053758;6208.6585237811905;5540.833774986757;5570.610057295991;5644.943550564524;5647.124695672177;5685.602007859451;6215.440610345091;6218.409251121137;6224.315325314212;6228.6574238416415;6230.937690623035;5758.021136406821;5873.207117039145;6042.607230530001;6049.21360223177;6051.939480605226;5981.252343457068;6048.788292409745;6065.302490213594;6066.150738896558;6103.664298463627;6034.456898879122;6041.365656605993;6075.787347442818;6077.8480537986015;6088.299845517734;5686.09022556389;5698.7435565399655;5971.044632858721;6070.6357618543025;6071.878562428727;4661.976690116596;4664.463586687507;4669.836555720533;4672.883177920579;4698.812047518061;4171.228322760238;4171.457710497677;4175.185838761473;4193.601607847249;4203.810828512725;5519.889602207933;5604.4395560444445;5668.858278542987;5717.42825717425;5725.341585717612;5957.165996760457;6105.236845394325;6114.908276375858;6115.694215289218;6120.14317995481;5740.65556066629;5771.971140144273;5775.220345253421;5780.104083866923;5782.681952492653;5160.638755287169;5231.450697676765;5275.340582427197;5287.391949925808;5360.195970604441;6205.100260462298;6205.906911396332;6206.813795586139;6206.968965155235;6219.129321894939;6028;6084.6349219047;6087.634741915499;6091.299500557493;6091.42131497507;5991.370906054802;6035.637861728311;6105.755769769159;6138.324784273637;6180.443760061616;5927.7036148191555;5958.97020514912;5960.821175364746;5963.52291816645;6082.817515474543;5906.084556893688;6054.697265136813;6058.242719660043;6059;6086.695665216633;5786.739596718242;5859.531237500904;5865.530757539472;5875.030619947661;5899.144624029406;5930.703464826827;5961.821145365646;5980.252468441445;5997;6002.489788368038;5610.49505544503;5710.057840456444;5852.678102704222;5902.586818922634;5916.083007133901;5924;6035.969820150871;6064.909026364519;6068.8786224276155;6074.210352654303;5846.532277417711;5848.56135789826;5854.0340843760305;5857.882842343214;5861.120831875082 13:32:31 INFO - 2016-01-28 13:32:31,966 DEBUG : BROWSER_OUTPUT: |1;ext.html;590.1708100119331;620.0667994668026;623.2552100240215;638.0461210490317;643.0226056394281;31958.520622190685;32690.836545817237;32751.508727369077;32752.508712369334;39631.60368396315;44378.77810610951;45158.54841451585;45218.773906130504;45249.54750452495;45286;8933.55332233389;9111.817763644724;9115.22520585751;9117.63529458824;9127.087291270853;8178.795530111735;8386.958065209696;8903.510306933149;9035.457872527637;10605.204609654269;10601.946990265038;10696.893031069667;10702.304350217211;10705.197110216764;10712.25014249003;10376.636817711382;10429.478526073743;10431.582736690523;10436.165106791477;10443.477826108665;10438.843417348746;10569.41868197249;10571.418571978538;10572.365658060464;10572.78854422915;41051.178976420306;41434.79282603598;41496.58503414987;41563.584364156275;41595.1680966379;3413.7269018478464;3447.7414193935306;3627.2020155565733;4099.569545197771;4105.794710264505;30295.69704302973;30347.544786828214;30567;30850.228744281347;31340.373192536248;4372.584604462571;4396.648268138541;4397.120575884804;4432.556744325541;4434.135343607998;305793;307335;307995;309042;309380;58393.70803146042;59800.40199597948;65290.347096529375;70827.2917270831;72652.63673681598;65334.67332663306;65589;65694.34305656978;65715.67142164259;65791.67104164448;16756.58108547296;16938.153092345332;17589.648207036043;17844;17868.731969020475;13874.375653095634;13937;13951.023428359917;14039.78940315896;14130.50543230982;21728.674069888963;21923.78076219249;21987.890060549595;21991.670124948138;22028.11887524481;8123.959380203061;8270.545120018336;8356.958215208884;8390.580470976427;8418;983.7196399026243;1051.64244156987;1065.7229120428744;1071.9571217151226;1206.2702065250396;28162.577561336595;29284.26789330241;29493.115206543836;33053.3389332212;33783.15542111418;1084.3331351218944;1092.847001419802;1133.3086817041599;1186.8694443611196;1215.866254711981;12980.35098245084;14544.200068996095;14584.343704533108;15132.924335378473;17300.307987680353;449190;454880;456211;456768;457169;56764;57289.713551431974;57358.42641573531;57486;57539.71230143906;1286.1832736212573;1342.1879762743595;1455.1487379882676;1488.0848278308763;1554.9689006219812;29162.562561561168;29368;29405;29426.705732943254;29985.400291994476;41976.790116049226;42611;42665.36001959911;42732.57267427286;42849;221120;224168;224543;225124;247408;33662.326753465284;33846;33848.1537961553;34152.316953661284;34391.82804085963;43862.78068609637;44816.77591612021;45047.09905801931;45095.77452112718;45192.77403612961;37031;37364.813175933945;37859.432108518944;38385.4242186373;38574.6142538571;37525.812370939064;37846;38181.42727859029;38206.426903595915;38275.617243827204;37310;37819.81090094642;37949.620503794606;37973.810130950274;38014.239715206095;32810.835945820116;33519.32961340808;33923.83038084794;34082;34216.65783342135;25982.74017259803;26396.8680156598;26481.867590661925;26490;26592.601110983738 13:32:31 INFO - 2016-01-28 13:32:31,967 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.14113526835155;385.6124594782244;387.19849910684894;389.606497437588;391.237087679026;14549.490767823101;16795.1602419879;16986.915065424688;18315.725264121033;18328.35850745224;16209.594760131002;16325.265363058661;16344;16632.334706611753;16808.66382672346;5472.5621950243885;5589.860253493654;5599.048161812501;5602.60781745278;5602.831915042555;4196.3705444183315;4290.935635965448;4292.055747735493;4296.935545966813;5568.192612071268;5985.371535988724;6152.938470615281;6154.753809847623;6174.536909731788;6188.226471691039;5959.40405959405;6119.051547010221;6121.234845644294;6133.386661333853;6137.202163718688;5310.787568497255;5369.087255166631;5400.324959380077;5400.567954563626;5401.945980540184;21896.89051554732;21904.780952190435;22056.558868822693;22479.775202247933;22482.10071597134;2289.3933107726466;2324.732655744594;2354.2937118864274;2366.455715185517;2381.3332266965276;13953.511627093003;14031.508897188549;14063.156210627396;14306.499272525516;14492.20292883891;1836.7244913262984;1856.183279357092;1904.838088762457;1907.4563749331373;1909.7421848050474;63990.68004659947;65866.67066664732;65936;66146;68150;10279.331843430153;10310.381377117246;10449.895501044892;10468.63359782404;10489;13951.860481395259;13965.511207107702;13977.79033314501;14012.789808152886;14015.579532614038;7623.9618801905635;7817.140114587391;7963.522188668582;7969.3226075784205;8098.35213182944;7470.962645186848;7616.200298968639;7656.732014379581;7677.500962437423;7718.996530451118;4405.0969551241915;4503;4524.25349817283;4533.9319910201375;4548.909021819545;1755.438259756891;1768.4341010876396;1782.9019403932648;1792.8893370003034;1838.3841413126752;903.2051794420868;934.5187228577288;938.2681508423441;966.9903300966901;1019.9541020654088;17175.31298748061;17243.655126897393;17792.199351029234;18015.549611259823;18023;855.1277696749281;943.4999450291357;948.2793077261331;950.334765664038;961.9470929098967;8950.194482496476;9122;9172.724818255463;9210.447373157633;9416.858747118798;635841;643052;643221;644176;655798;83384.08155714521;84600;86028.56985715157;87157.1284287149;89848.5507572458;1148.391352583149;1150.246588484544;1152.0898490192822;1152.3143729480946;1153.3887039868714;15026.32381542855;15150.16674082936;15340.079595224322;15350.385984560939;15405.306761195548;32938;33500.664993349754;33818.49272260967;34231.82884085563;35272.64727352796;48236.517634823205;49642.02863770962;49954.25068624046;50267;50668;10144.949275253577;10252.692419227435;10325.690229293134;10337.9483102584;10449.634262800766;17369.826301736823;17750.911245444207;17882.28470861203;18208.544786380447;18347.724784127982;14321.498747544203;14389.496367627084;15190.620234494227;15226.619334516725;15704.92147539255;14694;14807.718216248015;15059.623509412353;15302.311395986984;15635.921820390826;11611.6516504505;15464.072155670696;15472.071675699493;15516.767248491507;15645.295961681524;8655.826883462421;8832.293416526534;9504;9680.080392362714;9746.317757757173;10026.047525485359;13710.451581936612;14391.856081439051;14665;14708.338124784197 13:32:31 INFO - 2016-01-28 13:32:31,968 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1525.8931874768757;1760.1375326090215;1797.6282393933993;1844.787849397319;1858.0059668077572;8023.9598802005985;8140.5929703514885;8152.59237038148;8176.91823081769;8181.100078991321;8060.355171586274;8163.346932245421;8172.1827817218245;8180.509169449837;8184.7544573662735;2319.3042087373806;2334.0663734506247;2349.8002669773045;2390.0320370249988;2392.545416370893;2339.87130707811;2362.5629258587214;2391.1869964212165;2395.3053614451787;2396.197273913241;2071.8964051797425;2142.5179334649733;2319.860808351504;2391.6412538119334;2418;2251.8311126665567;2264.467850055236;2266.580682573729;2269.795718385337;2270.6366981282918;2359.97640023601;2435.975640243593;2440.7437219091917;2444;2445.1319781477496;6702.396784289437;6900.930990690079;7776.066871975399;7933.920660793434;7942.6425810838655;4829.855104346875;4904.754762261872;4934.013197360507;4946.653734238605;4947.703137811743;3340.732741380684;3345.6821601947777;3390.1863552747163;3405.557277553902;3428.400029994741;1084.371064782432;1085.16442339399;1091.4270008245655;1093.5352475198008;1101.8237082066912;10896.509657065371;10997.945010274898;11004.724881877937;11015.118790496821;11027.889721102767;4502.8198872045405;4509.6843220974215;4522.615577675934;4549.909001820011;4562.452505699271;9540.809183816285;9543.236541076698;9551.379160354554;9560.091791279818;9567.37812042215;4945.703257804471;4956.826511072168;4965.379327584052;4990;4994;4485.708428952108;4539.319102134707;4542.659300552472;4543.295789152687;4547.613452856544;3755.211405604799;3828.559715632682;3842.423636454554;3843.3082045231567;3849.230153969161;1199.9040076793835;1206.457094307565;1212.2665787198794;1219.3963987825905;1227;1030.7629245273629;1042.3954106618144;1045.5713157605499;1052.936823790575;1053.073295499955;7748.147703752583;7783.4162437817395;7806.648700808477;7808.57052862098;7809;535.2078923193617;541.1801121301232;541.9403865574784;543.2069178998706;549.5795716277051;5618.213450116987;5694.800681976111;6016.548758843104;6111.236095488064;6115.1744514490865;9069.954650226706;9128.406653567497;9206.309526785519;9211.585478653476;9339.859902101474;8080.070791858894;8254.174582541698;8364.707235246859;9872.062154095493;9873.802523949624;7576.4317676174505;7662.195469475736;7731.690732370642;7740.458167928304;7741.07107147146;7230.349268565854;7403.407727381904;7444.069491313586;7713.5371877685275;7795.961020194863;8559.486430814171;8567.571621419029;8626.741197764077;8652.610632521677;8847.203751662124;8531.146885311418;8808.427452215585;8847.46915185091;8984.59569319369;8986.82026359456;7658.961705191438;7669.808254793675;7750.8837367440665;7758.456908016385;7759;7882.290593846581;7906.841863162819;7945.046594408708;7956.801079973047;7956.920430795618;7265.527740696838;7367.336939675455;7403.14863790671;7435.367993720594;7517.361024312994;7119.430445564446;7160.176579693193;7201.063861697946;7220.7472738456;7232.0959880015;6798.116244888133;6828.112345395067;6847.726090956306;6959.756408525677;7011.6494175292055;6249.34381889895;6284.465820405317;6288.308286088618;6299;6305.117283580211;6724.731010759515;6761.695723692347;6797.252302246848;6814.182298124257;6822.761203357859 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: |4;prototype.html;348.38162261984974;357.90694419450944;362.72070505710593;363.06329669452816;368.4270958659284;6082.148499210114;6111.633302001883;6112.6943652817345;6149.600275982058;6165.013597824349;6047.818565443044;6048.092786082079;6057.546188914662;6062.181605483259;6063.363346848583;4508.6393088553;4607.1476776796235;4617.838375656853;4663.720176789387;4682.484926658065;4603.240465323218;4614;4619.284010978287;4647.302904564309;4662.766861656921;4426.601605855472;4622.445306563217;4624.306354046887;4628.629709623222;4635.026644404679;4483.663725220589;4520.638348932078;4522.68341216115;4524.841630542932;4557.726536407826;3982.203559288154;3997.2804895118866;4017.357222844331;4026.959730402688;4027.456293400383;5691.231683722686;5697;5697.173909783059;5701.173329867146;5711.971440142815;5157.793688252503;5277.498637629419;5334.093204155303;5431.592630552685;5434.8913021739345;6386.680665966683;6397.0724244984685;6397.328280530571;6402.711877965503;6412.807615771534;4521.321801729767;4525.70582912113;4531.45622525299;4532.229520981441;4536.931946020813;6439.8068057958335;6563.835904102388;6637.966810165966;6665.266820649725;6680.432163266129;4623.722576645412;4653.95346046542;4661.300804879227;4663.766811659403;4664.930026049612;4721.527847215251;4722.763861806965;4724.43306803179;4726.125666751662;4726.905461890743;5411.269478620415;5415.864603384947;5416.512513873691;5428.511433970962;5440.727963601804;6363.427291543783;6472.546921715435;6474.255460622088;6489.772857949949;6497.252815926135;1619.3441656129287;1660.10354408618;1660.709375859244;1660.842219989099;1662.8254033326327;1098.2257508456678;1114.777044591085;1123.9775204495863;1139.960101396447;1140.4240858366638;6274.372562743781;6277.843053923689;6279.4034566717;6280.937190628127;6290.056491526308;6687.230968438692;6688.598684078971;6689.096971908827;6689.230738465041;6693.2972037935315;6119.2350956130485;6267.310595834455;6272.874542509216;6273.404026617464;6275.874482510416;3603.3694103531775;3626.437902125175;3627.510286111394;3628.0748409156026;3630.636936306348;6835.282295359015;6853.040574319599;6854.897176542356;6863.485238607024;6864.622445765431;6573.868522629521;6741.224759152662;6806.081179040766;6832.521723479408;6841.828954276083;6883.346082122191;6907.998340240637;6914.965425172842;6924.826879328057;6930.27232140618;6703.597784132968;6712.798616041527;6722.697478613376;6724.966375168093;6728.05807187004;6498.090267362479;6632.436242919213;6633.1045308882685;6640.800775976729;6648.135742353463;6872.965635171792;6887.793366199022;6890.207626122859;6894.00036994643;6894.724211031503;4615.769211539477;4622.930656040229;4625.167469855458;4625.7455839929125;4627.375304333872;6587.703553340207;6699.229588597374;6706.362895524917;6741.764038258638;6756.628385438651;6583.111279977142;6595.901061483985;6596.30738772422;6597.208334999831;6598.505112116706;6563.540552161303;6569;6574.539782215199;6583.736650533925;6586.604803711793;6248.250209974832;6471.482281417381;6477.384648458389;6478.449331806849;6484.935150648622;6584.374484423972;6591.242007169237;6594.307597702172;6595;6600.735970561316;6432.517561183024;6452.612843229421;6461.127747754181;6466.191726034246;6466.482681385572 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: |5;yui.html;793.095870707394;805.190783262821;825.9545724985127;892.2282225874617;948.7343543807737;12871.292078935654;13127.343632818369;13163;13187.34063296835;13198.274094924787;12184.75630487392;12897.226166429997;12907.741845163115;12914.483420663186;12948;750.1298493747254;757.9166291707935;843.2705709561246;848.499385362636;859.7850537365658;855.2687452228348;856.2764464027917;861.6596444404456;862.9223369896708;862.9870551941726;904.5386852705135;905.6377449020379;909.1590278991939;909.2089881802808;913.2191975860643;892.9642814287421;898.2095755734944;900.2437952120217;900.3427497926517;900.4867225681364;668.976585819494;669.3273260373294;669.601587055706;669.712023829753;671.8521925176453;12127.93936030323;12251.081168912368;12287.69280767979;12288.447019884126;12304.07719421047;11523.366214858179;11901.761964760657;11986.101042421853;12008.458763527802;12334.383280836011;10076.69769906904;10648.574057037787;10651.520681569347;10715.83926241107;10788.676339709822;3691.741578089535;3776.4524143998965;3793.2223894101644;3811.218700166487;3841.1741475582885;46314.53685463136;47565.76217118892;48018.27972580414;49175.75412122916;49219.261711074;9831;10287.27989040775;10314.793704125876;10328.431936243578;10509.264351495322;17452;17675;17678.646427071388;17686.469405917844;17724.645507090045;7047.8238044048285;7358.521696089737;7638.197989211164;7676.57778822159;7756.844863102707;4168.374743788396;4205.873823785291;4215.714207166843;4238.0888109056705;4251.319788833772;3021.5165573508134;3043.482607956653;3048.3750831079574;3051.4659934511815;3053.908382748521;556.8190338140121;570.0764761086982;571.817018554067;578.1039388947115;582.3041465448832;699.9720011199495;700.403080975377;717.5300178383168;737.9114506259283;756.3079781999519;8557.358198135165;8945.73162805117;8983.77540561478;9034.14175653312;9118.40730352525;471.4554689333825;592.644413351994;638.1958731997623;699.5662689132669;700.2892064554482;4114.938275925863;4155.127423241092;4213.47331583552;4228.725132866415;4231.386448964944;58060.41939580635;58345.708271458374;58406.12390814141;58448.707756461794;58525.70737146287;52088.47911520912;52310.476895231324;52502.737486312326;52699;52965.470345296824;47724.284135737995;48387.51612483901;48562.75718621384;48974.02051958941;49399.50600494021;8758.255548278214;8867.866981995146;8903.376763626484;8942.284617230476;9070.628276153226;35517;36174.276514469035;36691;36714.082147946516;36722.8163859179;41772.58227417687;46907.296390553485;47306.52693473021;47446.76276618595;47805.76097119492;11103.777924441627;11272.943635281772;11432.885671143182;11488.310701357945;11523.942380288381;11746.765064698488;12019.519219231133;12029.699257518281;12125.029997600348;12176.695582610151;11458;11474.885251147381;11533.192676512563;11748.236364636272;12152.93923530412;11281.153913456359;11474.967252947275;11495.195336326376;11551.0181634562;12011.819822702491;11076.5569377224;11247.831282530606;11287.492062857027;11492.540298388305;11869.52521899149;9813.362131461432;9956.452395118049;9969.700908972742;10161.085502304828;10215.182785377003;9691.854622180532;9920.40477571348;10061.496925153566;10070.949645251727;10076.798464030531 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,705 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: __startTimestamp1454016751961__endTimestamp 13:32:31 INFO - 2016-01-28 13:32:31,970 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,971 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:32:31 INFO - 2016-01-28 13:32:31,971 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:32:31 INFO - 2016-01-28 13:32:31,971 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,971 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5615.92 Median:5846.53 stddev:623.13 (10.7%) stddev-sans-first:596.84 13:32:31 INFO - 2016-01-28 13:32:31,972 DEBUG : BROWSER_OUTPUT: Values: 3253.3 3360.3 3367.7 3377.6 3404.5 5439.2 5613.6 5625.9 5628.9 5643.8 5569.6 5642.4 5642.7 5659.9 5664.2 4980.7 5012.1 5084.8 5139.5 5187.3 5140.2 5146.0 5155.5 5157.8 5165.1 5062.8 5068.5 5092.2 5143.2 5153.7 5187.8 5218.0 5227.2 5231.9 5231.9 5160.8 5188.9 5213.6 5272.5 5289.5 5279.5 5321.9 5415.8 5419.5 5428.2 6106.4 6123.6 6162.4 6162.9 6163.4 5777.6 6158.9 6202.7 6205.4 6208.7 5540.8 5570.6 5644.9 5647.1 5685.6 6215.4 6218.4 6224.3 6228.7 6230.9 5758.0 5873.2 6042.6 6049.2 6051.9 5981.3 6048.8 6065.3 6066.2 6103.7 6034.5 6041.4 6075.8 6077.8 6088.3 5686.1 5698.7 5971.0 6070.6 6071.9 4662.0 4664.5 4669.8 4672.9 4698.8 4171.2 4171.5 4175.2 4193.6 4203.8 5519.9 5604.4 5668.9 5717.4 5725.3 5957.2 6105.2 6114.9 6115.7 6120.1 5740.7 5772.0 5775.2 5780.1 5782.7 5160.6 5231.5 5275.3 5287.4 5360.2 6205.1 6205.9 6206.8 6207.0 6219.1 6028.0 6084.6 6087.6 6091.3 6091.4 5991.4 6035.6 6105.8 6138.3 6180.4 5927.7 5959.0 5960.8 5963.5 6082.8 5906.1 6054.7 6058.2 6059.0 6086.7 5786.7 5859.5 5865.5 5875.0 5899.1 5930.7 5961.8 5980.3 5997.0 6002.5 5610.5 5710.1 5852.7 5902.6 5916.1 5924.0 6036.0 6064.9 6068.9 6074.2 5846.5 5848.6 5854.0 5857.9 5861.1 13:32:31 INFO - 2016-01-28 13:32:31,972 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,973 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50686.06 Median:18747.86 stddev:90621.04 (483.4%) stddev-sans-first:90797.20 13:32:31 INFO - 2016-01-28 13:32:31,973 DEBUG : BROWSER_OUTPUT: Values: 590.2 620.1 623.3 638.0 643.0 31958.5 32690.8 32751.5 32752.5 39631.6 44378.8 45158.5 45218.8 45249.5 45286.0 8933.6 9111.8 9115.2 9117.6 9127.1 8178.8 8387.0 8903.5 9035.5 10605.2 10601.9 10696.9 10702.3 10705.2 10712.3 10376.6 10429.5 10431.6 10436.2 10443.5 10438.8 10569.4 10571.4 10572.4 10572.8 41051.2 41434.8 41496.6 41563.6 41595.2 3413.7 3447.7 3627.2 4099.6 4105.8 30295.7 30347.5 30567.0 30850.2 31340.4 4372.6 4396.6 4397.1 4432.6 4434.1 305793.0 307335.0 307995.0 309042.0 309380.0 58393.7 59800.4 65290.3 70827.3 72652.6 65334.7 65589.0 65694.3 65715.7 65791.7 16756.6 16938.2 17589.6 17844.0 17868.7 13874.4 13937.0 13951.0 14039.8 14130.5 21728.7 21923.8 21987.9 21991.7 22028.1 8124.0 8270.5 8357.0 8390.6 8418.0 983.7 1051.6 1065.7 1072.0 1206.3 28162.6 29284.3 29493.1 33053.3 33783.2 1084.3 1092.8 1133.3 1186.9 1215.9 12980.4 14544.2 14584.3 15132.9 17300.3 449190.0 454880.0 456211.0 456768.0 457169.0 56764.0 57289.7 57358.4 57486.0 57539.7 1286.2 1342.2 1455.1 1488.1 1555.0 29162.6 29368.0 29405.0 29426.7 29985.4 41976.8 42611.0 42665.4 42732.6 42849.0 221120.0 224168.0 224543.0 225124.0 247408.0 33662.3 33846.0 33848.2 34152.3 34391.8 43862.8 44816.8 45047.1 45095.8 45192.8 37031.0 37364.8 37859.4 38385.4 38574.6 37525.8 37846.0 38181.4 38206.4 38275.6 37310.0 37819.8 37949.6 37973.8 38014.2 32810.8 33519.3 33923.8 34082.0 34216.7 25982.7 26396.9 26481.9 26490.0 26592.6 13:32:31 INFO - 2016-01-28 13:32:31,973 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,973 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32488.17 Median:17659.67 stddev:105254.78 (596.0%) stddev-sans-first:105522.44 13:32:31 INFO - 2016-01-28 13:32:31,974 DEBUG : BROWSER_OUTPUT: Values: 385.1 385.6 387.2 389.6 391.2 14549.5 16795.2 16986.9 18315.7 18328.4 16209.6 16325.3 16344.0 16632.3 16808.7 5472.6 5589.9 5599.0 5602.6 5602.8 4196.4 4290.9 4292.1 4296.9 5568.2 5985.4 6152.9 6154.8 6174.5 6188.2 5959.4 6119.1 6121.2 6133.4 6137.2 5310.8 5369.1 5400.3 5400.6 5401.9 21896.9 21904.8 22056.6 22479.8 22482.1 2289.4 2324.7 2354.3 2366.5 2381.3 13953.5 14031.5 14063.2 14306.5 14492.2 1836.7 1856.2 1904.8 1907.5 1909.7 63990.7 65866.7 65936.0 66146.0 68150.0 10279.3 10310.4 10449.9 10468.6 10489.0 13951.9 13965.5 13977.8 14012.8 14015.6 7624.0 7817.1 7963.5 7969.3 8098.4 7471.0 7616.2 7656.7 7677.5 7719.0 4405.1 4503.0 4524.3 4533.9 4548.9 1755.4 1768.4 1782.9 1792.9 1838.4 903.2 934.5 938.3 967.0 1020.0 17175.3 17243.7 17792.2 18015.5 18023.0 855.1 943.5 948.3 950.3 961.9 8950.2 9122.0 9172.7 9210.4 9416.9 635841.0 643052.0 643221.0 644176.0 655798.0 83384.1 84600.0 86028.6 87157.1 89848.6 1148.4 1150.2 1152.1 1152.3 1153.4 15026.3 15150.2 15340.1 15350.4 15405.3 32938.0 33500.7 33818.5 34231.8 35272.6 48236.5 49642.0 49954.3 50267.0 50668.0 10144.9 10252.7 10325.7 10337.9 10449.6 17369.8 17750.9 17882.3 18208.5 18347.7 14321.5 14389.5 15190.6 15226.6 15704.9 14694.0 14807.7 15059.6 15302.3 15635.9 11611.7 15464.1 15472.1 15516.8 15645.3 8655.8 8832.3 9504.0 9680.1 9746.3 10026.0 13710.5 14391.9 14665.0 14708.3 13:32:31 INFO - 2016-01-28 13:32:31,974 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,975 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5623.21 Median:6266.90 stddev:2908.64 (46.4%) stddev-sans-first:2900.49 13:32:31 INFO - 2016-01-28 13:32:31,975 DEBUG : BROWSER_OUTPUT: Values: 1525.9 1760.1 1797.6 1844.8 1858.0 8024.0 8140.6 8152.6 8176.9 8181.1 8060.4 8163.3 8172.2 8180.5 8184.8 2319.3 2334.1 2349.8 2390.0 2392.5 2339.9 2362.6 2391.2 2395.3 2396.2 2071.9 2142.5 2319.9 2391.6 2418.0 2251.8 2264.5 2266.6 2269.8 2270.6 2360.0 2436.0 2440.7 2444.0 2445.1 6702.4 6900.9 7776.1 7933.9 7942.6 4829.9 4904.8 4934.0 4946.7 4947.7 3340.7 3345.7 3390.2 3405.6 3428.4 1084.4 1085.2 1091.4 1093.5 1101.8 10896.5 10997.9 11004.7 11015.1 11027.9 4502.8 4509.7 4522.6 4549.9 4562.5 9540.8 9543.2 9551.4 9560.1 9567.4 4945.7 4956.8 4965.4 4990.0 4994.0 4485.7 4539.3 4542.7 4543.3 4547.6 3755.2 3828.6 3842.4 3843.3 3849.2 1199.9 1206.5 1212.3 1219.4 1227.0 1030.8 1042.4 1045.6 1052.9 1053.1 7748.1 7783.4 7806.6 7808.6 7809.0 535.2 541.2 541.9 543.2 549.6 5618.2 5694.8 6016.5 6111.2 6115.2 9070.0 9128.4 9206.3 9211.6 9339.9 8080.1 8254.2 8364.7 9872.1 9873.8 7576.4 7662.2 7731.7 7740.5 7741.1 7230.3 7403.4 7444.1 7713.5 7796.0 8559.5 8567.6 8626.7 8652.6 8847.2 8531.1 8808.4 8847.5 8984.6 8986.8 7659.0 7669.8 7750.9 7758.5 7759.0 7882.3 7906.8 7945.0 7956.8 7956.9 7265.5 7367.3 7403.1 7435.4 7517.4 7119.4 7160.2 7201.1 7220.7 7232.1 6798.1 6828.1 6847.7 6959.8 7011.6 6249.3 6284.5 6288.3 6299.0 6305.1 6724.7 6761.7 6797.3 6814.2 6822.8 13:32:31 INFO - 2016-01-28 13:32:31,975 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,975 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5417.90 Median:6206.63 stddev:1632.44 (26.3%) stddev-sans-first:1592.06 13:32:31 INFO - 2016-01-28 13:32:31,976 DEBUG : BROWSER_OUTPUT: Values: 348.4 357.9 362.7 363.1 368.4 6082.1 6111.6 6112.7 6149.6 6165.0 6047.8 6048.1 6057.5 6062.2 6063.4 4508.6 4607.1 4617.8 4663.7 4682.5 4603.2 4614.0 4619.3 4647.3 4662.8 4426.6 4622.4 4624.3 4628.6 4635.0 4483.7 4520.6 4522.7 4524.8 4557.7 3982.2 3997.3 4017.4 4027.0 4027.5 5691.2 5697.0 5697.2 5701.2 5712.0 5157.8 5277.5 5334.1 5431.6 5434.9 6386.7 6397.1 6397.3 6402.7 6412.8 4521.3 4525.7 4531.5 4532.2 4536.9 6439.8 6563.8 6638.0 6665.3 6680.4 4623.7 4654.0 4661.3 4663.8 4664.9 4721.5 4722.8 4724.4 4726.1 4726.9 5411.3 5415.9 5416.5 5428.5 5440.7 6363.4 6472.5 6474.3 6489.8 6497.3 1619.3 1660.1 1660.7 1660.8 1662.8 1098.2 1114.8 1124.0 1140.0 1140.4 6274.4 6277.8 6279.4 6280.9 6290.1 6687.2 6688.6 6689.1 6689.2 6693.3 6119.2 6267.3 6272.9 6273.4 6275.9 3603.4 3626.4 3627.5 3628.1 3630.6 6835.3 6853.0 6854.9 6863.5 6864.6 6573.9 6741.2 6806.1 6832.5 6841.8 6883.3 6908.0 6915.0 6924.8 6930.3 6703.6 6712.8 6722.7 6725.0 6728.1 6498.1 6632.4 6633.1 6640.8 6648.1 6873.0 6887.8 6890.2 6894.0 6894.7 4615.8 4622.9 4625.2 4625.7 4627.4 6587.7 6699.2 6706.4 6741.8 6756.6 6583.1 6595.9 6596.3 6597.2 6598.5 6563.5 6569.0 6574.5 6583.7 6586.6 6248.3 6471.5 6477.4 6478.4 6484.9 6584.4 6591.2 6594.3 6595.0 6600.7 6432.5 6452.6 6461.1 6466.2 6466.5 13:32:31 INFO - 2016-01-28 13:32:31,976 DEBUG : BROWSER_OUTPUT: 13:32:31 INFO - 2016-01-28 13:32:31,976 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14005.24 Median:46610.92 stddev:16334.70 (35.0%) stddev-sans-first:16350.39 13:32:31 INFO - 2016-01-28 13:32:31,978 DEBUG : BROWSER_OUTPUT: Values: 793.1 805.2 826.0 892.2 948.7 12871.3 13127.3 13163.0 13187.3 13198.3 12184.8 12897.2 12907.7 12914.5 12948.0 750.1 757.9 843.3 848.5 859.8 855.3 856.3 861.7 862.9 863.0 904.5 905.6 909.2 909.2 913.2 893.0 898.2 900.2 900.3 900.5 669.0 669.3 669.6 669.7 671.9 12127.9 12251.1 12287.7 12288.4 12304.1 11523.4 11901.8 11986.1 12008.5 12334.4 10076.7 10648.6 10651.5 10715.8 10788.7 3691.7 3776.5 3793.2 3811.2 3841.2 46314.5 47565.8 48018.3 49175.8 49219.3 9831.0 10287.3 10314.8 10328.4 10509.3 17452.0 17675.0 17678.6 17686.5 17724.6 7047.8 7358.5 7638.2 7676.6 7756.8 4168.4 4205.9 4215.7 4238.1 4251.3 3021.5 3043.5 3048.4 3051.5 3053.9 556.8 570.1 571.8 578.1 582.3 700.0 700.4 717.5 737.9 756.3 8557.4 8945.7 8983.8 9034.1 9118.4 471.5 592.6 638.2 699.6 700.3 4114.9 4155.1 4213.5 4228.7 4231.4 58060.4 58345.7 58406.1 58448.7 58525.7 52088.5 52310.5 52502.7 52699.0 52965.5 47724.3 48387.5 48562.8 48974.0 49399.5 8758.3 8867.9 8903.4 8942.3 9070.6 35517.0 36174.3 36691.0 36714.1 36722.8 41772.6 46907.3 47306.5 47446.8 47805.8 11103.8 11272.9 11432.9 11488.3 11523.9 11746.8 12019.5 12029.7 12125.0 12176.7 11458.0 11474.9 11533.2 11748.2 12152.9 11281.2 11475.0 11495.2 11551.0 12011.8 11076.6 11247.8 11287.5 11492.5 11869.5 9813.4 9956.5 9969.7 10161.1 10215.2 9691.9 9920.4 10061.5 10070.9 10076.8 13:32:31 INFO - 2016-01-28 13:32:31,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:32:31 INFO - 2016-01-28 13:32:31,978 DEBUG : BROWSER_OUTPUT: 13:32:32 INFO - 2016-01-28 13:32:32,515 INFO : Browser exited with error code: 0 13:32:32 INFO - 2016-01-28 13:32:32,538 INFO : Completed test dromaeo_css (00:18:29) 13:32:32 INFO - 2016-01-28 13:32:32,538 INFO : Starting test kraken 13:32:32 INFO - 2016-01-28 13:32:32,538 DEBUG : operating with platform_type : linux_ 13:32:32 INFO - 2016-01-28 13:32:32,538 INFO : Initialising browser for kraken test... 13:32:32 INFO - 2016-01-28 13:32:32,544 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2UycwV/profile http://localhost:49080/getInfo.html 13:32:36 INFO - 2016-01-28 13:32:36,249 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:32:36 INFO - 2016-01-28 13:32:36,249 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:32:36 INFO - 2016-01-28 13:32:36,249 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:32:36 INFO - 2016-01-28 13:32:36,249 DEBUG : BROWSER_OUTPUT: __metrics 13:32:36 INFO - 2016-01-28 13:32:36,487 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:32:37 INFO - 2016-01-28 13:32:37,366 INFO : Browser initialized. 13:32:37 INFO - 2016-01-28 13:32:37,366 INFO : Running cycle 1/1 for kraken test... 13:32:37 INFO - 2016-01-28 13:32:37,367 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2UycwV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:32:49 INFO - 2016-01-28 13:32:49,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 134471680 13:32:49 INFO - 2016-01-28 13:32:49,097 DEBUG : BROWSER_OUTPUT: 13:32:51 INFO - 2016-01-28 13:32:51,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49080/tests/kraken/driver.html?testName=audio-beat-detection) 13:32:52 INFO - 2016-01-28 13:32:52,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 165634048 13:32:52 INFO - 2016-01-28 13:32:52,099 DEBUG : BROWSER_OUTPUT: 13:32:54 INFO - 2016-01-28 13:32:54,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49080/tests/kraken/driver.html?testName=audio-dft) 13:32:55 INFO - 2016-01-28 13:32:55,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 163106816 13:32:55 INFO - 2016-01-28 13:32:55,228 DEBUG : BROWSER_OUTPUT: 13:32:58 INFO - 2016-01-28 13:32:58,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49080/tests/kraken/driver.html?testName=audio-fft) 13:32:58 INFO - 2016-01-28 13:32:58,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 161812480 13:32:58 INFO - 2016-01-28 13:32:58,569 DEBUG : BROWSER_OUTPUT: 13:33:00 INFO - 2016-01-28 13:33:00,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49080/tests/kraken/driver.html?testName=audio-oscillator) 13:33:01 INFO - 2016-01-28 13:33:01,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 160567296 13:33:01 INFO - 2016-01-28 13:33:01,103 DEBUG : BROWSER_OUTPUT: 13:33:03 INFO - 2016-01-28 13:33:03,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:33:03 INFO - 2016-01-28 13:33:03,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 160215040 13:33:03 INFO - 2016-01-28 13:33:03,851 DEBUG : BROWSER_OUTPUT: 13:33:06 INFO - 2016-01-28 13:33:06,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49080/tests/kraken/driver.html?testName=imaging-darkroom) 13:33:07 INFO - 2016-01-28 13:33:07,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 160088064 13:33:07 INFO - 2016-01-28 13:33:07,277 DEBUG : BROWSER_OUTPUT: 13:33:10 INFO - 2016-01-28 13:33:10,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49080/tests/kraken/driver.html?testName=imaging-desaturate) 13:33:11 INFO - 2016-01-28 13:33:11,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 160153600 13:33:11 INFO - 2016-01-28 13:33:11,156 DEBUG : BROWSER_OUTPUT: 13:33:13 INFO - 2016-01-28 13:33:13,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49080/tests/kraken/driver.html?testName=json-parse-financial) 13:33:14 INFO - 2016-01-28 13:33:14,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 159748096 13:33:14 INFO - 2016-01-28 13:33:14,410 DEBUG : BROWSER_OUTPUT: 13:33:15 INFO - 2016-01-28 13:33:15,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:33:16 INFO - 2016-01-28 13:33:16,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 166526976 13:33:16 INFO - 2016-01-28 13:33:16,513 DEBUG : BROWSER_OUTPUT: 13:33:18 INFO - 2016-01-28 13:33:18,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:33:18 INFO - 2016-01-28 13:33:18,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 164823040 13:33:18 INFO - 2016-01-28 13:33:18,836 DEBUG : BROWSER_OUTPUT: 13:33:20 INFO - 2016-01-28 13:33:20,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:33:21 INFO - 2016-01-28 13:33:21,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 170766336 13:33:21 INFO - 2016-01-28 13:33:21,342 DEBUG : BROWSER_OUTPUT: 13:33:23 INFO - 2016-01-28 13:33:23,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:33:24 INFO - 2016-01-28 13:33:24,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 176795648 13:33:24 INFO - 2016-01-28 13:33:24,262 DEBUG : BROWSER_OUTPUT: 13:33:26 INFO - 2016-01-28 13:33:26,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:33:27 INFO - 2016-01-28 13:33:27,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 174170112 13:33:27 INFO - 2016-01-28 13:33:27,298 DEBUG : BROWSER_OUTPUT: 13:33:28 INFO - 2016-01-28 13:33:28,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49080/tests/kraken/driver.html?testName=ai-astar) 13:33:29 INFO - 2016-01-28 13:33:29,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 232202240 13:33:29 INFO - 2016-01-28 13:33:29,194 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,197 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:33:29 INFO - 2016-01-28 13:33:29,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:33:29 INFO - 2016-01-28 13:33:29,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:33:29 INFO - 2016-01-28 13:33:29,198 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:33:29 INFO - 2016-01-28 13:33:29,198 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;102;108;109;110;98;108;107;109 13:33:29 INFO - 2016-01-28 13:33:29,198 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;122;156;157;131;148;152;122;160;125 13:33:29 INFO - 2016-01-28 13:33:29,198 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;158;158;158;159;160;160;159;159 13:33:29 INFO - 2016-01-28 13:33:29,198 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;72;70;154;72;72;70;71;154;70 13:33:29 INFO - 2016-01-28 13:33:29,199 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;140;92;92;92;141;92;91;142 13:33:29 INFO - 2016-01-28 13:33:29,199 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;110;109;108;110;108;109;108;108;110 13:33:29 INFO - 2016-01-28 13:33:29,199 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;144;145;145;145;145;145;145 13:33:29 INFO - 2016-01-28 13:33:29,199 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 13:33:29 INFO - 2016-01-28 13:33:29,199 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;56;56;58;56;57;57;53;55 13:33:29 INFO - 2016-01-28 13:33:29,199 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;63;64;63;64;62;64 13:33:29 INFO - 2016-01-28 13:33:29,199 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;75;76;78;78;78;77;76;83;76;76 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;122;121;115;123;109;112;121;110;118 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;146;139;140;143;134;152;141;143;141 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;65;63;65;64;71;64;65;66;62 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,871 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:33:29 INFO - 2016-01-28 13:33:29,200 DEBUG : BROWSER_OUTPUT: __startTimestamp1454016809196__endTimestamp 13:33:29 INFO - 2016-01-28 13:33:29,201 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,204 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:33:29 INFO - 2016-01-28 13:33:29,204 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:33:29 INFO - 2016-01-28 13:33:29,204 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,205 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:3.79 (3.5%) stddev-sans-first:4.00 13:33:29 INFO - 2016-01-28 13:33:29,205 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 102.0 108.0 109.0 110.0 98.0 108.0 107.0 109.0 13:33:29 INFO - 2016-01-28 13:33:29,205 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,205 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.10 Median:150.00 stddev:15.37 (10.2%) stddev-sans-first:16.16 13:33:29 INFO - 2016-01-28 13:33:29,205 DEBUG : BROWSER_OUTPUT: Values: 148.0 122.0 156.0 157.0 131.0 148.0 152.0 122.0 160.0 125.0 13:33:29 INFO - 2016-01-28 13:33:29,205 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,206 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.00 Median:159.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 13:33:29 INFO - 2016-01-28 13:33:29,206 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 158.0 158.0 158.0 159.0 160.0 160.0 159.0 159.0 13:33:29 INFO - 2016-01-28 13:33:29,206 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,206 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.50 Median:70.50 stddev:35.06 (49.7%) stddev-sans-first:36.61 13:33:29 INFO - 2016-01-28 13:33:29,206 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 70.0 154.0 72.0 72.0 70.0 71.0 154.0 70.0 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:92.00 stddev:23.74 (25.8%) stddev-sans-first:24.59 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 140.0 92.0 92.0 92.0 141.0 92.0 91.0 142.0 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 109.0 108.0 110.0 108.0 109.0 108.0 108.0 110.0 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 13:33:29 INFO - 2016-01-28 13:33:29,207 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.37 (2.4%) stddev-sans-first:1.41 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 56.0 56.0 58.0 56.0 57.0 57.0 53.0 55.0 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 63.0 64.0 63.0 64.0 62.0 64.0 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.50 stddev:2.26 (2.9%) stddev-sans-first:2.24 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: Values: 75.0 76.0 78.0 78.0 78.0 77.0 76.0 83.0 76.0 76.0 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:119.50 stddev:5.15 (4.3%) stddev-sans-first:5.43 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: Values: 115.0 122.0 121.0 115.0 123.0 109.0 112.0 121.0 110.0 118.0 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,208 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.50 Median:142.00 stddev:5.06 (3.6%) stddev-sans-first:4.96 13:33:29 INFO - 2016-01-28 13:33:29,209 DEBUG : BROWSER_OUTPUT: Values: 136.0 146.0 139.0 140.0 143.0 134.0 152.0 141.0 143.0 141.0 13:33:29 INFO - 2016-01-28 13:33:29,209 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,209 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.58 (4.0%) stddev-sans-first:2.55 13:33:29 INFO - 2016-01-28 13:33:29,209 DEBUG : BROWSER_OUTPUT: Values: 68.0 65.0 63.0 65.0 64.0 71.0 64.0 65.0 66.0 62.0 13:33:29 INFO - 2016-01-28 13:33:29,209 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:33:29 INFO - 2016-01-28 13:33:29,209 DEBUG : BROWSER_OUTPUT: 13:33:29 INFO - 2016-01-28 13:33:29,807 INFO : Browser exited with error code: 0 13:33:29 INFO - 2016-01-28 13:33:29,857 INFO : Completed test kraken (00:00:57) 13:33:29 INFO - 2016-01-28 13:33:29,857 INFO : Starting test v8_7 13:33:29 INFO - 2016-01-28 13:33:29,857 DEBUG : operating with platform_type : linux_ 13:33:29 INFO - 2016-01-28 13:33:29,857 INFO : Initialising browser for v8_7 test... 13:33:29 INFO - 2016-01-28 13:33:29,863 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCDuW42/profile http://localhost:49080/getInfo.html 13:33:33 INFO - 2016-01-28 13:33:33,747 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:33:33 INFO - 2016-01-28 13:33:33,747 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:33:33 INFO - 2016-01-28 13:33:33,747 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:33:33 INFO - 2016-01-28 13:33:33,747 DEBUG : BROWSER_OUTPUT: __metrics 13:33:33 INFO - 2016-01-28 13:33:33,945 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:33:34 INFO - 2016-01-28 13:33:34,715 INFO : Browser initialized. 13:33:34 INFO - 2016-01-28 13:33:34,715 INFO : Running cycle 1/1 for v8_7 test... 13:33:34 INFO - 2016-01-28 13:33:34,716 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCDuW42/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:33:46 INFO - 2016-01-28 13:33:46,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 134119424 13:33:46 INFO - 2016-01-28 13:33:46,498 DEBUG : BROWSER_OUTPUT: 13:34:07 INFO - 2016-01-28 13:34:07,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49080/tests/v8_7/run.html (next: http://localhost:49080/tests/v8_7/run.html) 13:34:08 INFO - 2016-01-28 13:34:08,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 423567360 13:34:08 INFO - 2016-01-28 13:34:08,079 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,079 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:34:08 INFO - 2016-01-28 13:34:08,079 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:34:08 INFO - 2016-01-28 13:34:08,079 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:34:08 INFO - 2016-01-28 13:34:08,079 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:34:08 INFO - 2016-01-28 13:34:08,080 DEBUG : BROWSER_OUTPUT: |0;Richards;168.29350387075058 13:34:08 INFO - 2016-01-28 13:34:08,080 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.39861065167054 13:34:08 INFO - 2016-01-28 13:34:08,080 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 13:34:08 INFO - 2016-01-28 13:34:08,080 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 13:34:08 INFO - 2016-01-28 13:34:08,080 DEBUG : BROWSER_OUTPUT: |4;RayTrace;958.7727708533077 13:34:08 INFO - 2016-01-28 13:34:08,080 DEBUG : BROWSER_OUTPUT: |5;Earley;542.0054200542005 13:34:08 INFO - 2016-01-28 13:34:08,081 DEBUG : BROWSER_OUTPUT: |6;Boyer;10536.842105263158 13:34:08 INFO - 2016-01-28 13:34:08,081 DEBUG : BROWSER_OUTPUT: |7;RegExp;23952.380952380954 13:34:08 INFO - 2016-01-28 13:34:08,081 DEBUG : BROWSER_OUTPUT: |8;Splay;517.3305742369374 13:34:08 INFO - 2016-01-28 13:34:08,081 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 13:34:08 INFO - 2016-01-28 13:34:08,081 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:34:08 INFO - 2016-01-28 13:34:08,082 DEBUG : BROWSER_OUTPUT: __startTimestamp1454016848077__endTimestamp 13:34:08 INFO - 2016-01-28 13:34:08,082 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,082 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:34:08 INFO - 2016-01-28 13:34:08,082 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:34:08 INFO - 2016-01-28 13:34:08,082 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,082 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.29 Median:168.29 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,083 DEBUG : BROWSER_OUTPUT: Values: 168.3 13:34:08 INFO - 2016-01-28 13:34:08,083 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,083 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.40 Median:165.40 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,083 DEBUG : BROWSER_OUTPUT: Values: 165.4 13:34:08 INFO - 2016-01-28 13:34:08,083 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,083 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,084 DEBUG : BROWSER_OUTPUT: Values: 278.5 13:34:08 INFO - 2016-01-28 13:34:08,084 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,084 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,084 DEBUG : BROWSER_OUTPUT: Values: 5133.3 13:34:08 INFO - 2016-01-28 13:34:08,084 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,084 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,085 DEBUG : BROWSER_OUTPUT: Values: 958.8 13:34:08 INFO - 2016-01-28 13:34:08,085 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,085 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.01 Median:542.01 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,085 DEBUG : BROWSER_OUTPUT: Values: 542.0 13:34:08 INFO - 2016-01-28 13:34:08,085 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,086 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10536.84 Median:10536.84 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: Values: 10536.8 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23952.38 Median:23952.38 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: Values: 23952.4 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.33 Median:517.33 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: Values: 517.3 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: Values: 4822.1 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:34:08 INFO - 2016-01-28 13:34:08,087 DEBUG : BROWSER_OUTPUT: 13:34:08 INFO - 2016-01-28 13:34:08,831 INFO : Browser exited with error code: 0 13:34:08 INFO - 2016-01-28 13:34:08,845 INFO : Completed test v8_7 (00:00:38) 13:34:09 INFO - 2016-01-28 13:34:09,156 INFO : Completed test suite (00:20:06) 13:34:09 INFO - 2016-01-28 13:34:09,157 DEBUG : Working with test: dromaeo_css 13:34:09 INFO - 2016-01-28 13:34:09,157 DEBUG : Generating results file: dromaeo_css 13:34:09 INFO - 2016-01-28 13:34:09,158 DEBUG : Working with test: kraken 13:34:09 INFO - 2016-01-28 13:34:09,158 DEBUG : Generating results file: kraken 13:34:09 INFO - 2016-01-28 13:34:09,158 INFO : javascript benchmark 13:34:09 INFO - 2016-01-28 13:34:09,159 DEBUG : Working with test: v8_7 13:34:09 INFO - 2016-01-28 13:34:09,159 DEBUG : Generating results file: v8_7 13:34:09 INFO - 2016-01-28 13:34:09,159 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:34:09 INFO - 2016-01-28 13:34:09,215 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 13:34:09 INFO - 2016-01-28 13:34:09,215 DEBUG : process_Request line: dromaeo_css 7261.82 graph.html#tests=[[72,53,35]] 13:34:09 INFO - 2016-01-28 13:34:09,216 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:34:09 INFO - 2016-01-28 13:34:09,245 DEBUG : process_Request line: kraken 1471.10 graph.html#tests=[[232,53,35]] 13:34:09 INFO - 2016-01-28 13:34:09,245 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:34:09 INFO - 2016-01-28 13:34:09,277 DEBUG : process_Request line: v8_7 23330.39 graph.html#tests=[[230,53,35]] 13:34:09 INFO - 2016-01-28 13:34:09,278 INFO : javascript benchmark 13:34:09 INFO - 2016-01-28 13:34:09,282 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3253.333066721322, 3360.277540328832, 3367.696907278346, 3377.5778027746533, 3404.5233667286575, 5439.18412238164, 5613.635113717605, 5625.887482250358, 5628.943710562899, 5643.814798892237, 5569.554435645138, 5642.379338272797, 5642.746076426561, 5659.915101273474, 5664.178694089354, 4980.701157930535, 5012.097822391968, 5084.77118529667, 5139.511746384106, 5187.273781670569, 5140.203268493389, 5145.970805838847, 5155.484451554852, 5157.76790044447, 5165.1219292720325, 5062.772175252123, 5068.46781087986, 5092.210707340369, 5143.228515722652, 5153.665011774241, 5187.792488300463, 5217.973910130425, 5227.18978558324, 5231.921521177204, 5231.9476805232225, 5160.8193713220235, 5188.948110518884, 5213.635045546814, 5272.472752724697, 5289.497497737709, 5279.472052794728, 5321.866953326159, 5415.808522125126, 5419.512243898029, 5428.240046393508, 6106.3893610639025, 6123.571350005502, 6162.383761623802, 6162.907556386658, 6163.445289923883, 5777.62445441045, 6158.907616385713, 6202.658853763086, 6205.379462053758, 6208.6585237811905, 5540.833774986757, 5570.610057295991, 5644.943550564524, 5647.124695672177, 5685.602007859451, 6215.440610345091, 6218.409251121137, 6224.315325314212, 6228.6574238416415, 6230.937690623035, 5758.021136406821, 5873.207117039145, 6042.607230530001, 6049.21360223177, 6051.939480605226, 5981.252343457068, 6048.788292409745, 6065.302490213594, 6066.150738896558, 6103.664298463627, 6034.456898879122, 6041.365656605993, 6075.787347442818, 6077.8480537986015, 6088.299845517734, 5686.09022556389, 5698.7435565399655, 5971.044632858721, 6070.6357618543025, 6071.878562428727, 4661.976690116596, 4664.463586687507, 4669.836555720533, 4672.883177920579, 4698.812047518061, 4171.228322760238, 4171.457710497677, 4175.185838761473, 4193.601607847249, 4203.810828512725, 5519.889602207933, 5604.4395560444445, 5668.858278542987, 5717.42825717425, 5725.341585717612, 5957.165996760457, 6105.236845394325, 6114.908276375858, 6115.694215289218, 6120.14317995481, 5740.65556066629, 5771.971140144273, 5775.220345253421, 5780.104083866923, 5782.681952492653, 5160.638755287169, 5231.450697676765, 5275.340582427197, 5287.391949925808, 5360.195970604441, 6205.100260462298, 6205.906911396332, 6206.813795586139, 6206.968965155235, 6219.129321894939, 6028.0, 6084.6349219047, 6087.634741915499, 6091.299500557493, 6091.42131497507, 5991.370906054802, 6035.637861728311, 6105.755769769159, 6138.324784273637, 6180.443760061616, 5927.7036148191555, 5958.97020514912, 5960.821175364746, 5963.52291816645, 6082.817515474543, 5906.084556893688, 6054.697265136813, 6058.242719660043, 6059.0, 6086.695665216633, 5786.739596718242, 5859.531237500904, 5865.530757539472, 5875.030619947661, 5899.144624029406, 5930.703464826827, 5961.821145365646, 5980.252468441445, 5997.0, 6002.489788368038, 5610.49505544503, 5710.057840456444, 5852.678102704222, 5902.586818922634, 5916.083007133901, 5924.0, 6035.969820150871, 6064.909026364519, 6068.8786224276155, 6074.210352654303, 5846.532277417711, 5848.56135789826, 5854.0340843760305, 5857.882842343214, 5861.120831875082], "unit": "ms", "name": "dojo.html", "value": 5575.513572448975}, {"lowerIsBetter": false, "replicates": [590.1708100119331, 620.0667994668026, 623.2552100240215, 638.0461210490317, 643.0226056394281, 31958.520622190685, 32690.836545817237, 32751.508727369077, 32752.508712369334, 39631.60368396315, 44378.77810610951, 45158.54841451585, 45218.773906130504, 45249.54750452495, 45286.0, 8933.55332233389, 9111.817763644724, 9115.22520585751, 9117.63529458824, 9127.087291270853, 8178.795530111735, 8386.958065209696, 8903.510306933149, 9035.457872527637, 10605.204609654269, 10601.946990265038, 10696.893031069667, 10702.304350217211, 10705.197110216764, 10712.25014249003, 10376.636817711382, 10429.478526073743, 10431.582736690523, 10436.165106791477, 10443.477826108665, 10438.843417348746, 10569.41868197249, 10571.418571978538, 10572.365658060464, 10572.78854422915, 41051.178976420306, 41434.79282603598, 41496.58503414987, 41563.584364156275, 41595.1680966379, 3413.7269018478464, 3447.7414193935306, 3627.2020155565733, 4099.569545197771, 4105.794710264505, 30295.69704302973, 30347.544786828214, 30567.0, 30850.228744281347, 31340.373192536248, 4372.584604462571, 4396.648268138541, 4397.120575884804, 4432.556744325541, 4434.135343607998, 305793.0, 307335.0, 307995.0, 309042.0, 309380.0, 58393.70803146042, 59800.40199597948, 65290.347096529375, 70827.2917270831, 72652.63673681598, 65334.67332663306, 65589.0, 65694.34305656978, 65715.67142164259, 65791.67104164448, 16756.58108547296, 16938.153092345332, 17589.648207036043, 17844.0, 17868.731969020475, 13874.375653095634, 13937.0, 13951.023428359917, 14039.78940315896, 14130.50543230982, 21728.674069888963, 21923.78076219249, 21987.890060549595, 21991.670124948138, 22028.11887524481, 8123.959380203061, 8270.545120018336, 8356.958215208884, 8390.580470976427, 8418.0, 983.7196399026243, 1051.64244156987, 1065.7229120428744, 1071.9571217151226, 1206.2702065250396, 28162.577561336595, 29284.26789330241, 29493.115206543836, 33053.3389332212, 33783.15542111418, 1084.3331351218944, 1092.847001419802, 1133.3086817041599, 1186.8694443611196, 1215.866254711981, 12980.35098245084, 14544.200068996095, 14584.343704533108, 15132.924335378473, 17300.307987680353, 449190.0, 454880.0, 456211.0, 456768.0, 457169.0, 56764.0, 57289.713551431974, 57358.42641573531, 57486.0, 57539.71230143906, 1286.1832736212573, 1342.1879762743595, 1455.1487379882676, 1488.0848278308763, 1554.9689006219812, 29162.562561561168, 29368.0, 29405.0, 29426.705732943254, 29985.400291994476, 41976.790116049226, 42611.0, 42665.36001959911, 42732.57267427286, 42849.0, 221120.0, 224168.0, 224543.0, 225124.0, 247408.0, 33662.326753465284, 33846.0, 33848.1537961553, 34152.316953661284, 34391.82804085963, 43862.78068609637, 44816.77591612021, 45047.09905801931, 45095.77452112718, 45192.77403612961, 37031.0, 37364.813175933945, 37859.432108518944, 38385.4242186373, 38574.6142538571, 37525.812370939064, 37846.0, 38181.42727859029, 38206.426903595915, 38275.617243827204, 37310.0, 37819.81090094642, 37949.620503794606, 37973.810130950274, 38014.239715206095, 32810.835945820116, 33519.32961340808, 33923.83038084794, 34082.0, 34216.65783342135, 25982.74017259803, 26396.8680156598, 26481.867590661925, 26490.0, 26592.601110983738], "unit": "ms", "name": "ext.html", "value": 19823.54459891966}, {"lowerIsBetter": false, "replicates": [385.14113526835155, 385.6124594782244, 387.19849910684894, 389.606497437588, 391.237087679026, 14549.490767823101, 16795.1602419879, 16986.915065424688, 18315.725264121033, 18328.35850745224, 16209.594760131002, 16325.265363058661, 16344.0, 16632.334706611753, 16808.66382672346, 5472.5621950243885, 5589.860253493654, 5599.048161812501, 5602.60781745278, 5602.831915042555, 4196.3705444183315, 4290.935635965448, 4292.055747735493, 4296.935545966813, 5568.192612071268, 5985.371535988724, 6152.938470615281, 6154.753809847623, 6174.536909731788, 6188.226471691039, 5959.40405959405, 6119.051547010221, 6121.234845644294, 6133.386661333853, 6137.202163718688, 5310.787568497255, 5369.087255166631, 5400.324959380077, 5400.567954563626, 5401.945980540184, 21896.89051554732, 21904.780952190435, 22056.558868822693, 22479.775202247933, 22482.10071597134, 2289.3933107726466, 2324.732655744594, 2354.2937118864274, 2366.455715185517, 2381.3332266965276, 13953.511627093003, 14031.508897188549, 14063.156210627396, 14306.499272525516, 14492.20292883891, 1836.7244913262984, 1856.183279357092, 1904.838088762457, 1907.4563749331373, 1909.7421848050474, 63990.68004659947, 65866.67066664732, 65936.0, 66146.0, 68150.0, 10279.331843430153, 10310.381377117246, 10449.895501044892, 10468.63359782404, 10489.0, 13951.860481395259, 13965.511207107702, 13977.79033314501, 14012.789808152886, 14015.579532614038, 7623.9618801905635, 7817.140114587391, 7963.522188668582, 7969.3226075784205, 8098.35213182944, 7470.962645186848, 7616.200298968639, 7656.732014379581, 7677.500962437423, 7718.996530451118, 4405.0969551241915, 4503.0, 4524.25349817283, 4533.9319910201375, 4548.909021819545, 1755.438259756891, 1768.4341010876396, 1782.9019403932648, 1792.8893370003034, 1838.3841413126752, 903.2051794420868, 934.5187228577288, 938.2681508423441, 966.9903300966901, 1019.9541020654088, 17175.31298748061, 17243.655126897393, 17792.199351029234, 18015.549611259823, 18023.0, 855.1277696749281, 943.4999450291357, 948.2793077261331, 950.334765664038, 961.9470929098967, 8950.194482496476, 9122.0, 9172.724818255463, 9210.447373157633, 9416.858747118798, 635841.0, 643052.0, 643221.0, 644176.0, 655798.0, 83384.08155714521, 84600.0, 86028.56985715157, 87157.1284287149, 89848.5507572458, 1148.391352583149, 1150.246588484544, 1152.0898490192822, 1152.3143729480946, 1153.3887039868714, 15026.32381542855, 15150.16674082936, 15340.079595224322, 15350.385984560939, 15405.306761195548, 32938.0, 33500.664993349754, 33818.49272260967, 34231.82884085563, 35272.64727352796, 48236.517634823205, 49642.02863770962, 49954.25068624046, 50267.0, 50668.0, 10144.949275253577, 10252.692419227435, 10325.690229293134, 10337.9483102584, 10449.634262800766, 17369.826301736823, 17750.911245444207, 17882.28470861203, 18208.544786380447, 18347.724784127982, 14321.498747544203, 14389.496367627084, 15190.620234494227, 15226.619334516725, 15704.92147539255, 14694.0, 14807.718216248015, 15059.623509412353, 15302.311395986984, 15635.921820390826, 11611.6516504505, 15464.072155670696, 15472.071675699493, 15516.767248491507, 15645.295961681524, 8655.826883462421, 8832.293416526534, 9504.0, 9680.080392362714, 9746.317757757173, 10026.047525485359, 13710.451581936612, 14391.856081439051, 14665.0, 14708.338124784197], "unit": "ms", "name": "jquery.html", "value": 9269.395737073051}, {"lowerIsBetter": false, "replicates": [1525.8931874768757, 1760.1375326090215, 1797.6282393933993, 1844.787849397319, 1858.0059668077572, 8023.9598802005985, 8140.5929703514885, 8152.59237038148, 8176.91823081769, 8181.100078991321, 8060.355171586274, 8163.346932245421, 8172.1827817218245, 8180.509169449837, 8184.7544573662735, 2319.3042087373806, 2334.0663734506247, 2349.8002669773045, 2390.0320370249988, 2392.545416370893, 2339.87130707811, 2362.5629258587214, 2391.1869964212165, 2395.3053614451787, 2396.197273913241, 2071.8964051797425, 2142.5179334649733, 2319.860808351504, 2391.6412538119334, 2418.0, 2251.8311126665567, 2264.467850055236, 2266.580682573729, 2269.795718385337, 2270.6366981282918, 2359.97640023601, 2435.975640243593, 2440.7437219091917, 2444.0, 2445.1319781477496, 6702.396784289437, 6900.930990690079, 7776.066871975399, 7933.920660793434, 7942.6425810838655, 4829.855104346875, 4904.754762261872, 4934.013197360507, 4946.653734238605, 4947.703137811743, 3340.732741380684, 3345.6821601947777, 3390.1863552747163, 3405.557277553902, 3428.400029994741, 1084.371064782432, 1085.16442339399, 1091.4270008245655, 1093.5352475198008, 1101.8237082066912, 10896.509657065371, 10997.945010274898, 11004.724881877937, 11015.118790496821, 11027.889721102767, 4502.8198872045405, 4509.6843220974215, 4522.615577675934, 4549.909001820011, 4562.452505699271, 9540.809183816285, 9543.236541076698, 9551.379160354554, 9560.091791279818, 9567.37812042215, 4945.703257804471, 4956.826511072168, 4965.379327584052, 4990.0, 4994.0, 4485.708428952108, 4539.319102134707, 4542.659300552472, 4543.295789152687, 4547.613452856544, 3755.211405604799, 3828.559715632682, 3842.423636454554, 3843.3082045231567, 3849.230153969161, 1199.9040076793835, 1206.457094307565, 1212.2665787198794, 1219.3963987825905, 1227.0, 1030.7629245273629, 1042.3954106618144, 1045.5713157605499, 1052.936823790575, 1053.073295499955, 7748.147703752583, 7783.4162437817395, 7806.648700808477, 7808.57052862098, 7809.0, 535.2078923193617, 541.1801121301232, 541.9403865574784, 543.2069178998706, 549.5795716277051, 5618.213450116987, 5694.800681976111, 6016.548758843104, 6111.236095488064, 6115.1744514490865, 9069.954650226706, 9128.406653567497, 9206.309526785519, 9211.585478653476, 9339.859902101474, 8080.070791858894, 8254.174582541698, 8364.707235246859, 9872.062154095493, 9873.802523949624, 7576.4317676174505, 7662.195469475736, 7731.690732370642, 7740.458167928304, 7741.07107147146, 7230.349268565854, 7403.407727381904, 7444.069491313586, 7713.5371877685275, 7795.961020194863, 8559.486430814171, 8567.571621419029, 8626.741197764077, 8652.610632521677, 8847.203751662124, 8531.146885311418, 8808.427452215585, 8847.46915185091, 8984.59569319369, 8986.82026359456, 7658.961705191438, 7669.808254793675, 7750.8837367440665, 7758.456908016385, 7759.0, 7882.290593846581, 7906.841863162819, 7945.046594408708, 7956.801079973047, 7956.920430795618, 7265.527740696838, 7367.336939675455, 7403.14863790671, 7435.367993720594, 7517.361024312994, 7119.430445564446, 7160.176579693193, 7201.063861697946, 7220.7472738456, 7232.0959880015, 6798.116244888133, 6828.112345395067, 6847.726090956306, 6959.756408525677, 7011.6494175292055, 6249.34381889895, 6284.465820405317, 6288.308286088618, 6299.0, 6305.117283580211, 6724.731010759515, 6761.695723692347, 6797.252302246848, 6814.182298124257, 6822.761203357859], "unit": "ms", "name": "mootools.html", "value": 4551.327442581081}, {"lowerIsBetter": false, "replicates": [348.38162261984974, 357.90694419450944, 362.72070505710593, 363.06329669452816, 368.4270958659284, 6082.148499210114, 6111.633302001883, 6112.6943652817345, 6149.600275982058, 6165.013597824349, 6047.818565443044, 6048.092786082079, 6057.546188914662, 6062.181605483259, 6063.363346848583, 4508.6393088553, 4607.1476776796235, 4617.838375656853, 4663.720176789387, 4682.484926658065, 4603.240465323218, 4614.0, 4619.284010978287, 4647.302904564309, 4662.766861656921, 4426.601605855472, 4622.445306563217, 4624.306354046887, 4628.629709623222, 4635.026644404679, 4483.663725220589, 4520.638348932078, 4522.68341216115, 4524.841630542932, 4557.726536407826, 3982.203559288154, 3997.2804895118866, 4017.357222844331, 4026.959730402688, 4027.456293400383, 5691.231683722686, 5697.0, 5697.173909783059, 5701.173329867146, 5711.971440142815, 5157.793688252503, 5277.498637629419, 5334.093204155303, 5431.592630552685, 5434.8913021739345, 6386.680665966683, 6397.0724244984685, 6397.328280530571, 6402.711877965503, 6412.807615771534, 4521.321801729767, 4525.70582912113, 4531.45622525299, 4532.229520981441, 4536.931946020813, 6439.8068057958335, 6563.835904102388, 6637.966810165966, 6665.266820649725, 6680.432163266129, 4623.722576645412, 4653.95346046542, 4661.300804879227, 4663.766811659403, 4664.930026049612, 4721.527847215251, 4722.763861806965, 4724.43306803179, 4726.125666751662, 4726.905461890743, 5411.269478620415, 5415.864603384947, 5416.512513873691, 5428.511433970962, 5440.727963601804, 6363.427291543783, 6472.546921715435, 6474.255460622088, 6489.772857949949, 6497.252815926135, 1619.3441656129287, 1660.10354408618, 1660.709375859244, 1660.842219989099, 1662.8254033326327, 1098.2257508456678, 1114.777044591085, 1123.9775204495863, 1139.960101396447, 1140.4240858366638, 6274.372562743781, 6277.843053923689, 6279.4034566717, 6280.937190628127, 6290.056491526308, 6687.230968438692, 6688.598684078971, 6689.096971908827, 6689.230738465041, 6693.2972037935315, 6119.2350956130485, 6267.310595834455, 6272.874542509216, 6273.404026617464, 6275.874482510416, 3603.3694103531775, 3626.437902125175, 3627.510286111394, 3628.0748409156026, 3630.636936306348, 6835.282295359015, 6853.040574319599, 6854.897176542356, 6863.485238607024, 6864.622445765431, 6573.868522629521, 6741.224759152662, 6806.081179040766, 6832.521723479408, 6841.828954276083, 6883.346082122191, 6907.998340240637, 6914.965425172842, 6924.826879328057, 6930.27232140618, 6703.597784132968, 6712.798616041527, 6722.697478613376, 6724.966375168093, 6728.05807187004, 6498.090267362479, 6632.436242919213, 6633.1045308882685, 6640.800775976729, 6648.135742353463, 6872.965635171792, 6887.793366199022, 6890.207626122859, 6894.00036994643, 6894.724211031503, 4615.769211539477, 4622.930656040229, 4625.167469855458, 4625.7455839929125, 4627.375304333872, 6587.703553340207, 6699.229588597374, 6706.362895524917, 6741.764038258638, 6756.628385438651, 6583.111279977142, 6595.901061483985, 6596.30738772422, 6597.208334999831, 6598.505112116706, 6563.540552161303, 6569.0, 6574.539782215199, 6583.736650533925, 6586.604803711793, 6248.250209974832, 6471.482281417381, 6477.384648458389, 6478.449331806849, 6484.935150648622, 6584.374484423972, 6591.242007169237, 6594.307597702172, 6595.0, 6600.735970561316, 6432.517561183024, 6452.612843229421, 6461.127747754181, 6466.191726034246, 6466.482681385572], "unit": "ms", "name": "prototype.html", "value": 4894.709633072541}, {"lowerIsBetter": false, "replicates": [793.095870707394, 805.190783262821, 825.9545724985127, 892.2282225874617, 948.7343543807737, 12871.292078935654, 13127.343632818369, 13163.0, 13187.34063296835, 13198.274094924787, 12184.75630487392, 12897.226166429997, 12907.741845163115, 12914.483420663186, 12948.0, 750.1298493747254, 757.9166291707935, 843.2705709561246, 848.499385362636, 859.7850537365658, 855.2687452228348, 856.2764464027917, 861.6596444404456, 862.9223369896708, 862.9870551941726, 904.5386852705135, 905.6377449020379, 909.1590278991939, 909.2089881802808, 913.2191975860643, 892.9642814287421, 898.2095755734944, 900.2437952120217, 900.3427497926517, 900.4867225681364, 668.976585819494, 669.3273260373294, 669.601587055706, 669.712023829753, 671.8521925176453, 12127.93936030323, 12251.081168912368, 12287.69280767979, 12288.447019884126, 12304.07719421047, 11523.366214858179, 11901.761964760657, 11986.101042421853, 12008.458763527802, 12334.383280836011, 10076.69769906904, 10648.574057037787, 10651.520681569347, 10715.83926241107, 10788.676339709822, 3691.741578089535, 3776.4524143998965, 3793.2223894101644, 3811.218700166487, 3841.1741475582885, 46314.53685463136, 47565.76217118892, 48018.27972580414, 49175.75412122916, 49219.261711074, 9831.0, 10287.27989040775, 10314.793704125876, 10328.431936243578, 10509.264351495322, 17452.0, 17675.0, 17678.646427071388, 17686.469405917844, 17724.645507090045, 7047.8238044048285, 7358.521696089737, 7638.197989211164, 7676.57778822159, 7756.844863102707, 4168.374743788396, 4205.873823785291, 4215.714207166843, 4238.0888109056705, 4251.319788833772, 3021.5165573508134, 3043.482607956653, 3048.3750831079574, 3051.4659934511815, 3053.908382748521, 556.8190338140121, 570.0764761086982, 571.817018554067, 578.1039388947115, 582.3041465448832, 699.9720011199495, 700.403080975377, 717.5300178383168, 737.9114506259283, 756.3079781999519, 8557.358198135165, 8945.73162805117, 8983.77540561478, 9034.14175653312, 9118.40730352525, 471.4554689333825, 592.644413351994, 638.1958731997623, 699.5662689132669, 700.2892064554482, 4114.938275925863, 4155.127423241092, 4213.47331583552, 4228.725132866415, 4231.386448964944, 58060.41939580635, 58345.708271458374, 58406.12390814141, 58448.707756461794, 58525.70737146287, 52088.47911520912, 52310.476895231324, 52502.737486312326, 52699.0, 52965.470345296824, 47724.284135737995, 48387.51612483901, 48562.75718621384, 48974.02051958941, 49399.50600494021, 8758.255548278214, 8867.866981995146, 8903.376763626484, 8942.284617230476, 9070.628276153226, 35517.0, 36174.276514469035, 36691.0, 36714.082147946516, 36722.8163859179, 41772.58227417687, 46907.296390553485, 47306.52693473021, 47446.76276618595, 47805.76097119492, 11103.777924441627, 11272.943635281772, 11432.885671143182, 11488.310701357945, 11523.942380288381, 11746.765064698488, 12019.519219231133, 12029.699257518281, 12125.029997600348, 12176.695582610151, 11458.0, 11474.885251147381, 11533.192676512563, 11748.236364636272, 12152.93923530412, 11281.153913456359, 11474.967252947275, 11495.195336326376, 11551.0181634562, 12011.819822702491, 11076.5569377224, 11247.831282530606, 11287.492062857027, 11492.540298388305, 11869.52521899149, 9813.362131461432, 9956.452395118049, 9969.700908972742, 10161.085502304828, 10215.182785377003, 9691.854622180532, 9920.40477571348, 10061.496925153566, 10070.949645251727, 10076.798464030531], "unit": "ms", "name": "yui.html", "value": 6424.655780214624}], "name": "dromaeo_css", "value": 7261.817695613356}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 102.0, 108.0, 109.0, 110.0, 98.0, 108.0, 107.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 106.8}, {"lowerIsBetter": true, "replicates": [148.0, 122.0, 156.0, 157.0, 131.0, 148.0, 152.0, 122.0, 160.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.1}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 158.0, 158.0, 158.0, 159.0, 160.0, 160.0, 159.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 159.0}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 154.0, 72.0, 72.0, 70.0, 71.0, 154.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 140.0, 92.0, 92.0, 92.0, 141.0, 92.0, 91.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [108.0, 110.0, 109.0, 108.0, 110.0, 108.0, 109.0, 108.0, 108.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 58.0, 56.0, 57.0, 57.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 62.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 78.0, 78.0, 78.0, 77.0, 76.0, 83.0, 76.0, 76.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.3}, {"lowerIsBetter": true, "replicates": [115.0, 122.0, 121.0, 115.0, 123.0, 109.0, 112.0, 121.0, 110.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [136.0, 146.0, 139.0, 140.0, 143.0, 134.0, 152.0, 141.0, 143.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.5}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 63.0, 65.0, 64.0, 71.0, 64.0, 65.0, 66.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1471.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.29350387075058], "unit": "score", "name": "Richards", "value": 209.76448399999992}, {"lowerIsBetter": false, "replicates": [165.39861065167054], "unit": "score", "name": "DeltaBlue", "value": 399.749428}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [958.7727708533077], "unit": "score", "name": "RayTrace", "value": 771.8085270000001}, {"lowerIsBetter": false, "replicates": [542.0054200542005], "unit": "score", "name": "Earley", "value": 1229.624235}, {"lowerIsBetter": false, "replicates": [10536.842105263158], "unit": "score", "name": "Boyer", "value": 63.25073426573423}, {"lowerIsBetter": false, "replicates": [23952.380952380954], "unit": "score", "name": "RegExp", "value": 38.0331709741551}, {"lowerIsBetter": false, "replicates": [517.3305742369374], "unit": "score", "name": "Splay", "value": 157.52210300000002}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23330.38646638381}]} 13:34:09 INFO - RETURN: dromaeo_css: 7261.82 13:34:09 INFO - RETURN: kraken: 1471.10 13:34:09 INFO - RETURN: v8_7: 23330.39 13:34:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23330.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1471.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7261.82"}}} 13:34:09 INFO - Return code: 0 13:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:34:09 INFO - # TBPL SUCCESS # 13:34:09 INFO - Running post-action listener: _resource_record_post_action 13:34:09 INFO - Running post-run listener: _resource_record_post_run 13:34:10 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 20480; Write bytes: 510656512; Read time: 32; Write time: 489708 13:34:10 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 246493184; Read time: 0; Write time: 341880 13:34:10 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 20480; Write bytes: 263565312; Read time: 32; Write time: 147828 13:34:10 INFO - Running post-run listener: _upload_blobber_files 13:34:10 INFO - Blob upload gear active. 13:34:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:34:10 INFO - Copying logs to upload dir... 13:34:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.817136 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-01-28 13:34:10.067922) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-28 13:34:10.073646) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009972 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454006488/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-01-28 13:34:10.123843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:34:10.124146) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1454014667.686650-532025275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:34:10.174555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 13:34:10.175178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 13:34:10.175468) ========= ========= Total master_lag: 0.25 =========