builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1453010772.72 results: success (0) buildid: 20160116193624 builduid: 99c88b450d2b4114adc016ddb85b3a06 revision: d2b4d101d00691f835c4f109524a3506d5f51626 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.722429) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.722864) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.723175) ========= 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.769675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.769986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.795741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.796029) ========= 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004769 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.850123) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.850430) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.850827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.851130) ========= 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-16 22:06: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% 34.8M=0s 2016-01-16 22:06:13 (34.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.040353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.040685) ========= 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014185 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.093905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.094240) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2b4d101d00691f835c4f109524a3506d5f51626 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2b4d101d00691f835c4f109524a3506d5f51626 --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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-16 22:06:13,517 truncating revision to first 12 chars 2016-01-16 22:06:13,517 Setting DEBUG logging. 2016-01-16 22:06:13,517 attempt 1/10 2016-01-16 22:06:13,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2b4d101d006?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-16 22:06:13,777 unpacking tar archive at: mozilla-inbound-d2b4d101d006/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.676482) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.676836) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004304 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.731959) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.732261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.749168) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.749448) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.749917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-16 22:06:13.750460) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:06:14 INFO - MultiFileLogger online at 20160116 22:06:14 in /builds/slave/test-pgo 22:06:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:06:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:06:14 INFO - {'append_to_log': False, 22:06:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:06:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:06:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:06:14 INFO - 'branch': 'Mozilla-Inbound', 22:06:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:06:14 INFO - 'config_files': ('talos/linux_config.py',), 22:06:14 INFO - 'default_actions': ('clobber', 22:06:14 INFO - 'read-buildbot-config', 22:06:14 INFO - 'download-and-extract', 22:06:14 INFO - 'populate-webroot', 22:06:14 INFO - 'create-virtualenv', 22:06:14 INFO - 'install', 22:06:14 INFO - 'run-tests'), 22:06:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:06:14 INFO - 'download_minidump_stackwalk': True, 22:06:14 INFO - 'download_symbols': 'ondemand', 22:06:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:06:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:06:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:06:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:06:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:06:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:06:14 INFO - 'installer_path': 'installer.exe', 22:06:14 INFO - 'log_level': 'info', 22:06:14 INFO - 'log_name': 'talos', 22:06:14 INFO - 'log_to_console': True, 22:06:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:06:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:06:14 INFO - 'opt_config_files': (), 22:06:14 INFO - 'pip_index': False, 22:06:14 INFO - 'sps_profile': False, 22:06:14 INFO - 'sps_profile_interval': 0, 22:06:14 INFO - 'suite': 'dromaeojs-e10s', 22:06:14 INFO - 'system_bits': '32', 22:06:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:06:14 INFO - 'title': 'talos-linux64-ix-028', 22:06:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:06:14 INFO - 'use_talos_json': True, 22:06:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:06:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:06:14 INFO - 'work_dir': 'build'} 22:06:14 INFO - ##### 22:06:14 INFO - ##### Running clobber step. 22:06:14 INFO - ##### 22:06:14 INFO - Running pre-action listener: _resource_record_pre_action 22:06:14 INFO - Running main action method: clobber 22:06:14 INFO - rmtree: /builds/slave/test-pgo/build 22:06:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:06:15 INFO - Running post-action listener: _resource_record_post_action 22:06:15 INFO - ##### 22:06:15 INFO - ##### Running read-buildbot-config step. 22:06:15 INFO - ##### 22:06:15 INFO - Running pre-action listener: _resource_record_pre_action 22:06:15 INFO - Running main action method: read_buildbot_config 22:06:15 INFO - Using buildbot properties: 22:06:15 INFO - { 22:06:15 INFO - "project": "", 22:06:15 INFO - "product": "firefox", 22:06:15 INFO - "script_repo_revision": "production", 22:06:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:06:15 INFO - "repository": "", 22:06:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:06:15 INFO - "buildid": "20160116193624", 22:06:15 INFO - "pgo_build": "True", 22:06:15 INFO - "basedir": "/builds/slave/test-pgo", 22:06:15 INFO - "buildnumber": 314, 22:06:15 INFO - "slavename": "talos-linux64-ix-028", 22:06:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:06:15 INFO - "platform": "ubuntu64_hw", 22:06:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:06:15 INFO - "branch": "mozilla-inbound", 22:06:15 INFO - "repo_path": "integration/mozilla-inbound", 22:06:15 INFO - "revision": "d2b4d101d00691f835c4f109524a3506d5f51626", 22:06:15 INFO - "stage_platform": "linux64-pgo", 22:06:15 INFO - "builduid": "99c88b450d2b4114adc016ddb85b3a06", 22:06:15 INFO - "slavebuilddir": "test" 22:06:15 INFO - } 22:06:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:06:15 INFO - Running post-action listener: _resource_record_post_action 22:06:15 INFO - ##### 22:06:15 INFO - ##### Running download-and-extract step. 22:06:15 INFO - ##### 22:06:15 INFO - Running pre-action listener: _resource_record_pre_action 22:06:15 INFO - Running main action method: download_and_extract 22:06:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:06: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')]} 22:06:15 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json 22:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json 22:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:06:25 INFO - Downloaded 1448 bytes. 22:06:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:06:25 INFO - Using the following test package requirements: 22:06:25 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:25 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:06:25 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:06:25 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'jsshell-linux-x86_64.zip'], 22:06:25 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:06:25 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:25 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:06:25 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:06:25 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:06:25 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:25 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:06:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:06: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')]} 22:06:25 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:36 INFO - Downloaded 22483984 bytes. 22:06:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:06:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:06:37 INFO - Return code: 0 22:06:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:06: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')]} 22:06:37 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:43 INFO - Downloaded 22483984 bytes. 22:06:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:06:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:06:44 INFO - Return code: 0 22:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:44 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:06:46 INFO - Downloaded 11132144 bytes. 22:06:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:06:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:06:46 INFO - Return code: 0 22:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:46 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:06:50 INFO - Downloaded 55936272 bytes. 22:06:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:50 INFO - mkdir: /builds/slave/test-pgo/properties 22:06:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:06:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:06:50 INFO - Contents: 22:06:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:50 INFO - Running post-action listener: _resource_record_post_action 22:06:50 INFO - Running post-action listener: set_extra_try_arguments 22:06:50 INFO - ##### 22:06:50 INFO - ##### Running populate-webroot step. 22:06:50 INFO - ##### 22:06:50 INFO - Running pre-action listener: _resource_record_pre_action 22:06:50 INFO - Running main action method: populate_webroot 22:06:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:06:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:06:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:06:50 INFO - '--tppagecycles', 22:06:50 INFO - '7'], 22:06:50 INFO - 'tests': ['tsvgm']}}, 22:06:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:06:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:06:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:06:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:06:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'tests': ['damp', 'tps']}, 22:06:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['damp', 'tps']}, 22:06:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:06:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:06:50 INFO - 'other': {'tests': ['a11yr', 22:06:50 INFO - 'ts_paint', 22:06:50 INFO - 'tpaint', 22:06:50 INFO - 'sessionrestore', 22:06:50 INFO - 'sessionrestore_no_auto_restore']}, 22:06:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['a11yr', 22:06:50 INFO - 'ts_paint', 22:06:50 INFO - 'tpaint', 22:06:50 INFO - 'sessionrestore', 22:06:50 INFO - 'sessionrestore_no_auto_restore']}, 22:06:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['a11yr', 22:06:50 INFO - 'ts_paint', 22:06:50 INFO - 'tpaint', 22:06:50 INFO - 'sessionrestore', 22:06:50 INFO - 'sessionrestore_no_auto_restore']}, 22:06:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['a11yr', 22:06:50 INFO - 'ts_paint', 22:06:50 INFO - 'tpaint', 22:06:50 INFO - 'sessionrestore', 22:06:50 INFO - 'sessionrestore_no_auto_restore']}, 22:06:50 INFO - 'other_l64': {'tests': ['a11yr', 22:06:50 INFO - 'ts_paint', 22:06:50 INFO - 'tpaint', 22:06:50 INFO - 'sessionrestore', 22:06:50 INFO - 'sessionrestore_no_auto_restore']}, 22:06:50 INFO - 'other_nol64': {'tests': ['a11yr', 22:06:50 INFO - 'ts_paint', 22:06:50 INFO - 'tpaint', 22:06:50 INFO - 'sessionrestore', 22:06:50 INFO - 'sessionrestore_no_auto_restore']}, 22:06:50 INFO - 'svgr': {'tests': ['tsvgx', 22:06:50 INFO - 'tsvgr_opacity', 22:06:50 INFO - 'tart', 22:06:50 INFO - 'tscrollx', 22:06:50 INFO - 'cart']}, 22:06:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['tsvgx', 22:06:50 INFO - 'tsvgr_opacity', 22:06:50 INFO - 'tart', 22:06:50 INFO - 'tscrollx', 22:06:50 INFO - 'cart']}, 22:06:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'tests': ['tp5o']}, 22:06:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'talos_options': ['--e10s'], 22:06:50 INFO - 'tests': ['tp5o']}, 22:06:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'talos_options': ['--xperf_path', 22:06:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:50 INFO - 'tests': ['tp5n']}, 22:06:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:50 INFO - 'talos_options': ['--e10s', 22:06:50 INFO - '--xperf_path', 22:06:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:50 INFO - 'tests': ['tp5n']}}, 22:06:50 INFO - 'talos.zip': {'path': '', 22:06:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:06:50 INFO - Running post-action listener: _resource_record_post_action 22:06:50 INFO - ##### 22:06:50 INFO - ##### Running create-virtualenv step. 22:06:50 INFO - ##### 22:06:50 INFO - Running pre-action listener: _resource_record_pre_action 22:06:50 INFO - Running main action method: create_virtualenv 22:06:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:06:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:06:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:06:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:06:50 INFO - Using real prefix '/usr' 22:06:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:06:50 INFO - Installing distribute.............................................................................................................................................................................................done. 22:06:52 INFO - Installing pip.................done. 22:06:52 INFO - Return code: 0 22:06:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:06:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:06:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:06:52 INFO - Using env: {'DISPLAY': ':0', 22:06:52 INFO - 'HOME': '/home/cltbld', 22:06:52 INFO - 'LANG': 'en_US.UTF-8', 22:06:52 INFO - 'LANGUAGE': 'en_US:en', 22:06:52 INFO - 'LOGNAME': 'cltbld', 22:06:52 INFO - 'MAIL': '/var/mail/cltbld', 22:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:52 INFO - 'MOZ_NO_REMOTE': '1', 22:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:52 INFO - 'NO_EM_RESTART': '1', 22:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:06:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:06:52 INFO - 'SHELL': '/bin/bash', 22:06:52 INFO - 'SHLVL': '1', 22:06:52 INFO - 'TERM': 'linux', 22:06:52 INFO - 'TMOUT': '86400', 22:06:52 INFO - 'USER': 'cltbld', 22:06:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:52 INFO - '_': '/tools/buildbot/bin/python'} 22:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:52 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 22:06:52 INFO - Cleaning up... 22:06:52 INFO - Return code: 0 22:06:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:06:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:06:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:06:53 INFO - Using env: {'DISPLAY': ':0', 22:06:53 INFO - 'HOME': '/home/cltbld', 22:06:53 INFO - 'LANG': 'en_US.UTF-8', 22:06:53 INFO - 'LANGUAGE': 'en_US:en', 22:06:53 INFO - 'LOGNAME': 'cltbld', 22:06:53 INFO - 'MAIL': '/var/mail/cltbld', 22:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:53 INFO - 'MOZ_NO_REMOTE': '1', 22:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:53 INFO - 'NO_EM_RESTART': '1', 22:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:06:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:06:53 INFO - 'SHELL': '/bin/bash', 22:06:53 INFO - 'SHLVL': '1', 22:06:53 INFO - 'TERM': 'linux', 22:06:53 INFO - 'TMOUT': '86400', 22:06:53 INFO - 'USER': 'cltbld', 22:06:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:53 INFO - '_': '/tools/buildbot/bin/python'} 22:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:53 INFO - Downloading/unpacking psutil>=0.7.1 22:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:06:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:06:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:06:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:55 INFO - Installing collected packages: psutil 22:06:55 INFO - Running setup.py install for psutil 22:06:55 INFO - building 'psutil._psutil_linux' extension 22:06:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:06:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:06:55 INFO - building 'psutil._psutil_posix' extension 22:06:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:06:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:06:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:55 INFO - Successfully installed psutil 22:06:55 INFO - Cleaning up... 22:06:55 INFO - Return code: 0 22:06:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:06:55 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')]} 22:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:55 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')]} 22:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:06:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:06:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:06:55 INFO - Using env: {'DISPLAY': ':0', 22:06:55 INFO - 'HOME': '/home/cltbld', 22:06:55 INFO - 'LANG': 'en_US.UTF-8', 22:06:55 INFO - 'LANGUAGE': 'en_US:en', 22:06:55 INFO - 'LOGNAME': 'cltbld', 22:06:55 INFO - 'MAIL': '/var/mail/cltbld', 22:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:55 INFO - 'MOZ_NO_REMOTE': '1', 22:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:55 INFO - 'NO_EM_RESTART': '1', 22:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:06:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:06:55 INFO - 'SHELL': '/bin/bash', 22:06:55 INFO - 'SHLVL': '1', 22:06:55 INFO - 'TERM': 'linux', 22:06:55 INFO - 'TMOUT': '86400', 22:06:55 INFO - 'USER': 'cltbld', 22:06:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:55 INFO - '_': '/tools/buildbot/bin/python'} 22:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:06:55 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 22:06:55 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 22:06:55 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 22:06:55 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 22:06:55 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 22:06:55 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 22:06:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:06:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:06:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:06:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:06:57 INFO - Installing collected packages: mozsystemmonitor 22:06:57 INFO - Running setup.py install for mozsystemmonitor 22:06:57 INFO - Successfully installed mozsystemmonitor 22:06:57 INFO - Cleaning up... 22:06:57 INFO - Return code: 0 22:06:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:06:57 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')]} 22:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:57 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')]} 22:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:06:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:06:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:06:57 INFO - Using env: {'DISPLAY': ':0', 22:06:57 INFO - 'HOME': '/home/cltbld', 22:06:57 INFO - 'LANG': 'en_US.UTF-8', 22:06:57 INFO - 'LANGUAGE': 'en_US:en', 22:06:57 INFO - 'LOGNAME': 'cltbld', 22:06:57 INFO - 'MAIL': '/var/mail/cltbld', 22:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:57 INFO - 'MOZ_NO_REMOTE': '1', 22:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:57 INFO - 'NO_EM_RESTART': '1', 22:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:06:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:06:57 INFO - 'SHELL': '/bin/bash', 22:06:57 INFO - 'SHLVL': '1', 22:06:57 INFO - 'TERM': 'linux', 22:06:57 INFO - 'TMOUT': '86400', 22:06:57 INFO - 'USER': 'cltbld', 22:06:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:57 INFO - '_': '/tools/buildbot/bin/python'} 22:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:57 INFO - Downloading/unpacking blobuploader==1.2.4 22:06:57 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 22:06:57 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 22:06:57 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 22:06:57 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 22:06:57 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 22:06:57 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 22:06:59 INFO - Downloading blobuploader-1.2.4.tar.gz 22:06:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:06:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:06:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:06:59 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 22:06:59 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 22:06:59 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 22:06:59 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 22:06:59 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 22:06:59 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 22:06:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:06:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:07:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:00 INFO - Downloading docopt-0.6.1.tar.gz 22:07:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:07:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:00 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:00 INFO - Running setup.py install for blobuploader 22:07:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:07:00 INFO - Running setup.py install for requests 22:07:00 INFO - Running setup.py install for docopt 22:07:00 INFO - Successfully installed blobuploader requests docopt 22:07:00 INFO - Cleaning up... 22:07:00 INFO - Return code: 0 22:07:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:00 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')]} 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 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')]} 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:07:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:00 INFO - Using env: {'DISPLAY': ':0', 22:07:00 INFO - 'HOME': '/home/cltbld', 22:07:00 INFO - 'LANG': 'en_US.UTF-8', 22:07:00 INFO - 'LANGUAGE': 'en_US:en', 22:07:00 INFO - 'LOGNAME': 'cltbld', 22:07:00 INFO - 'MAIL': '/var/mail/cltbld', 22:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:00 INFO - 'MOZ_NO_REMOTE': '1', 22:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:00 INFO - 'NO_EM_RESTART': '1', 22:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:00 INFO - 'SHELL': '/bin/bash', 22:07:00 INFO - 'SHLVL': '1', 22:07:00 INFO - 'TERM': 'linux', 22:07:00 INFO - 'TMOUT': '86400', 22:07:00 INFO - 'USER': 'cltbld', 22:07:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:00 INFO - '_': '/tools/buildbot/bin/python'} 22:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:01 INFO - Running setup.py (path:/tmp/pip-5geewe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:01 INFO - Running setup.py (path:/tmp/pip-jZLUAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:01 INFO - Running setup.py (path:/tmp/pip-oVtfYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:01 INFO - Running setup.py (path:/tmp/pip-GrpZ8x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:01 INFO - Running setup.py (path:/tmp/pip-7sUPkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:01 INFO - Running setup.py (path:/tmp/pip-wanUMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:01 INFO - Running setup.py (path:/tmp/pip-AAbp0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:01 INFO - Running setup.py (path:/tmp/pip-4LRgT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:01 INFO - Running setup.py (path:/tmp/pip-UWm5Pq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:01 INFO - Running setup.py (path:/tmp/pip-_ZQlft-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:01 INFO - Running setup.py (path:/tmp/pip-FoWxHx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:01 INFO - Running setup.py (path:/tmp/pip-LrbgLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:01 INFO - Running setup.py (path:/tmp/pip-lrw2of-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:02 INFO - Running setup.py (path:/tmp/pip-0hMSKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:02 INFO - Running setup.py (path:/tmp/pip-nwp8ZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:02 INFO - Running setup.py (path:/tmp/pip-thz9Fr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:02 INFO - Running setup.py (path:/tmp/pip-R_WxAC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:02 INFO - Running setup.py install for manifestparser 22:07:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:07:02 INFO - Running setup.py install for mozcrash 22:07:02 INFO - Running setup.py install for mozdebug 22:07:02 INFO - Running setup.py install for mozdevice 22:07:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:07:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:07:02 INFO - Running setup.py install for mozfile 22:07:02 INFO - Running setup.py install for mozhttpd 22:07:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:07:02 INFO - Running setup.py install for mozinfo 22:07:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Running setup.py install for mozInstall 22:07:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Running setup.py install for mozleak 22:07:03 INFO - Running setup.py install for mozlog 22:07:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Running setup.py install for moznetwork 22:07:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Running setup.py install for mozprocess 22:07:03 INFO - Running setup.py install for mozprofile 22:07:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Running setup.py install for mozrunner 22:07:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:07:03 INFO - Running setup.py install for mozscreenshot 22:07:03 INFO - Running setup.py install for moztest 22:07:03 INFO - Running setup.py install for mozversion 22:07:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:07:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:04 INFO - Cleaning up... 22:07:04 INFO - Return code: 0 22:07:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:07:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:07:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:04 INFO - Using env: {'DISPLAY': ':0', 22:07:04 INFO - 'HOME': '/home/cltbld', 22:07:04 INFO - 'LANG': 'en_US.UTF-8', 22:07:04 INFO - 'LANGUAGE': 'en_US:en', 22:07:04 INFO - 'LOGNAME': 'cltbld', 22:07:04 INFO - 'MAIL': '/var/mail/cltbld', 22:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:04 INFO - 'MOZ_NO_REMOTE': '1', 22:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:04 INFO - 'NO_EM_RESTART': '1', 22:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:04 INFO - 'SHELL': '/bin/bash', 22:07:04 INFO - 'SHLVL': '1', 22:07:04 INFO - 'TERM': 'linux', 22:07:04 INFO - 'TMOUT': '86400', 22:07:04 INFO - 'USER': 'cltbld', 22:07:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:04 INFO - '_': '/tools/buildbot/bin/python'} 22:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:04 INFO - Running setup.py (path:/tmp/pip-6F2JWK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:04 INFO - Running setup.py (path:/tmp/pip-OlWQO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:04 INFO - Running setup.py (path:/tmp/pip-Z9uZSA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:04 INFO - Running setup.py (path:/tmp/pip-INPYbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:04 INFO - Running setup.py (path:/tmp/pip-Abfii6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:04 INFO - Running setup.py (path:/tmp/pip-8SAisu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:04 INFO - Running setup.py (path:/tmp/pip-KeCQ5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:04 INFO - Running setup.py (path:/tmp/pip-9Di3LU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:04 INFO - Running setup.py (path:/tmp/pip-Xm7_UI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:04 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)) 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:04 INFO - Running setup.py (path:/tmp/pip-uD84Se-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:05 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)) 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:05 INFO - Running setup.py (path:/tmp/pip-ZEM5uz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:05 INFO - Running setup.py (path:/tmp/pip-WIWUZe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:05 INFO - Running setup.py (path:/tmp/pip-HC92jb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:05 INFO - Running setup.py (path:/tmp/pip-eMPCVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:05 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)) 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:05 INFO - Running setup.py (path:/tmp/pip-6A8Nya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:05 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)) 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:05 INFO - Running setup.py (path:/tmp/pip-uiwhyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:05 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)) 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:05 INFO - Running setup.py (path:/tmp/pip-2X_brW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:05 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)) 22:07:05 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)) 22:07:05 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)) 22:07:05 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)) 22:07:05 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:05 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:07 INFO - Downloading blessings-1.5.1.tar.gz 22:07:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:07:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:07 INFO - Installing collected packages: blessings 22:07:07 INFO - Running setup.py install for blessings 22:07:07 INFO - Successfully installed blessings 22:07:07 INFO - Cleaning up... 22:07:07 INFO - Return code: 0 22:07:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:07:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:07 INFO - Reading from file tmpfile_stdout 22:07:07 INFO - Current package versions: 22:07:07 INFO - argparse == 1.2.1 22:07:07 INFO - blessings == 1.5.1 22:07:07 INFO - blobuploader == 1.2.4 22:07:07 INFO - docopt == 0.6.1 22:07:07 INFO - manifestparser == 1.1 22:07:07 INFO - mozInstall == 1.12 22:07:07 INFO - mozcrash == 0.16 22:07:07 INFO - mozdebug == 0.1 22:07:07 INFO - mozdevice == 0.48 22:07:07 INFO - mozfile == 1.2 22:07:07 INFO - mozhttpd == 0.7 22:07:07 INFO - mozinfo == 0.9 22:07:07 INFO - mozleak == 0.1 22:07:07 INFO - mozlog == 3.1 22:07:07 INFO - moznetwork == 0.27 22:07:07 INFO - mozprocess == 0.22 22:07:07 INFO - mozprofile == 0.28 22:07:07 INFO - mozrunner == 6.11 22:07:07 INFO - mozscreenshot == 0.1 22:07:07 INFO - mozsystemmonitor == 0.0 22:07:07 INFO - moztest == 0.7 22:07:07 INFO - mozversion == 1.4 22:07:07 INFO - psutil == 3.1.1 22:07:07 INFO - requests == 1.2.3 22:07:07 INFO - wsgiref == 0.1.2 22:07:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:07 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')]} 22:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:07 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')]} 22:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:07:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:07:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:07 INFO - Using env: {'DISPLAY': ':0', 22:07:07 INFO - 'HOME': '/home/cltbld', 22:07:07 INFO - 'LANG': 'en_US.UTF-8', 22:07:07 INFO - 'LANGUAGE': 'en_US:en', 22:07:07 INFO - 'LOGNAME': 'cltbld', 22:07:07 INFO - 'MAIL': '/var/mail/cltbld', 22:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:07 INFO - 'MOZ_NO_REMOTE': '1', 22:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:07 INFO - 'NO_EM_RESTART': '1', 22:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:07 INFO - 'SHELL': '/bin/bash', 22:07:07 INFO - 'SHLVL': '1', 22:07:07 INFO - 'TERM': 'linux', 22:07:07 INFO - 'TMOUT': '86400', 22:07:07 INFO - 'USER': 'cltbld', 22:07:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:07 INFO - '_': '/tools/buildbot/bin/python'} 22:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 22:07:07 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 2)) 22:07:07 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 3)) 22:07:07 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 4)) 22:07:07 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 5)) 22:07:07 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 6)) 22:07:07 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 7)) 22:07:07 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 8)) 22:07:07 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 9)) 22:07:07 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:07:07 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 4)) 22:07:07 INFO - Cleaning up... 22:07:07 INFO - Return code: 0 22:07:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:07:07 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')]} 22:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:07 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')]} 22:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:07:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:07:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:07:07 INFO - Using env: {'DISPLAY': ':0', 22:07:07 INFO - 'HOME': '/home/cltbld', 22:07:07 INFO - 'LANG': 'en_US.UTF-8', 22:07:07 INFO - 'LANGUAGE': 'en_US:en', 22:07:07 INFO - 'LOGNAME': 'cltbld', 22:07:07 INFO - 'MAIL': '/var/mail/cltbld', 22:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:07 INFO - 'MOZ_NO_REMOTE': '1', 22:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:07 INFO - 'NO_EM_RESTART': '1', 22:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:07 INFO - 'SHELL': '/bin/bash', 22:07:07 INFO - 'SHLVL': '1', 22:07:07 INFO - 'TERM': 'linux', 22:07:07 INFO - 'TMOUT': '86400', 22:07:07 INFO - 'USER': 'cltbld', 22:07:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:07 INFO - '_': '/tools/buildbot/bin/python'} 22:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:08 INFO - Downloading/unpacking jsonschema 22:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:07:10 INFO - Downloading/unpacking functools32 (from jsonschema) 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:07:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:10 INFO - warning: no files found matching '*.txt' 22:07:10 INFO - no previously-included directories found matching 'build' 22:07:10 INFO - no previously-included directories found matching 'dist' 22:07:10 INFO - no previously-included directories found matching '.git*' 22:07:10 INFO - Installing collected packages: jsonschema, functools32 22:07:10 INFO - Running setup.py install for functools32 22:07:10 INFO - warning: no files found matching '*.txt' 22:07:10 INFO - no previously-included directories found matching 'build' 22:07:10 INFO - no previously-included directories found matching 'dist' 22:07:10 INFO - no previously-included directories found matching '.git*' 22:07:10 INFO - Successfully installed jsonschema functools32 22:07:10 INFO - Cleaning up... 22:07:10 INFO - Return code: 0 22:07:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f9bd67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2546230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, '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': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', '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 22:07:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:07:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:07:10 INFO - Using env: {'DISPLAY': ':0', 22:07:10 INFO - 'HOME': '/home/cltbld', 22:07:10 INFO - 'LANG': 'en_US.UTF-8', 22:07:10 INFO - 'LANGUAGE': 'en_US:en', 22:07:10 INFO - 'LOGNAME': 'cltbld', 22:07:10 INFO - 'MAIL': '/var/mail/cltbld', 22:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:10 INFO - 'MOZ_NO_REMOTE': '1', 22:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:10 INFO - 'NO_EM_RESTART': '1', 22:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:10 INFO - 'SHELL': '/bin/bash', 22:07:10 INFO - 'SHLVL': '1', 22:07:10 INFO - 'TERM': 'linux', 22:07:10 INFO - 'TMOUT': '86400', 22:07:10 INFO - 'USER': 'cltbld', 22:07:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:10 INFO - '_': '/tools/buildbot/bin/python'} 22:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:10 INFO - Downloading/unpacking flake8 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:07:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:07:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:07:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:07:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:07:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:07:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:07:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:13 INFO - no previously-included directories found matching 'docs/_build' 22:07:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:07:13 INFO - Running setup.py install for pep8 22:07:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:13 INFO - no previously-included directories found matching 'docs/_build' 22:07:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:07:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:07:13 INFO - Cleaning up... 22:07:13 INFO - Return code: 0 22:07:13 INFO - Running post-action listener: _resource_record_post_action 22:07:13 INFO - Running post-action listener: _start_resource_monitoring 22:07:13 INFO - Starting resource monitoring. 22:07:13 INFO - ##### 22:07:13 INFO - ##### Running install step. 22:07:13 INFO - ##### 22:07:13 INFO - Running pre-action listener: _resource_record_pre_action 22:07:13 INFO - Running main action method: install 22:07:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:13 INFO - Reading from file tmpfile_stdout 22:07:13 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:07:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:07:13 INFO - Reading from file tmpfile_stdout 22:07:13 INFO - Output received: 22:07:13 INFO - Usage: mozinstall [options] installer 22:07:13 INFO - Options: 22:07:13 INFO - -h, --help show this help message and exit 22:07:13 INFO - -d DEST, --destination=DEST 22:07:13 INFO - Directory to install application into. [default: 22:07:13 INFO - "/builds/slave/test-pgo"] 22:07:13 INFO - --app=APP Application being installed. [default: firefox] 22:07:13 INFO - mkdir: /builds/slave/test-pgo/build/application 22:07:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:07:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:07:29 INFO - Reading from file tmpfile_stdout 22:07:29 INFO - Output received: 22:07:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:07:29 INFO - Running post-action listener: _resource_record_post_action 22:07:29 INFO - ##### 22:07:29 INFO - ##### Running run-tests step. 22:07:29 INFO - ##### 22:07:29 INFO - Running pre-action listener: _resource_record_pre_action 22:07:29 INFO - Running main action method: run_tests 22:07:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:07:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:07:29 INFO - Python 2.7.3 22:07:29 INFO - Return code: 0 22:07:29 INFO - grabbing minidump binary from tooltool 22:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:29 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 0x25d87f0>, '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 0x25442d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2544760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:07:29 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 22:07:29 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 22:07:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:29 INFO - Return code: 0 22:07:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:07:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:07:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:07:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:07:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:07:30 INFO - Return code: 0 22:07:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:07:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:07:30 INFO - Using env: {'DISPLAY': ':0', 22:07:30 INFO - 'HOME': '/home/cltbld', 22:07:30 INFO - 'LANG': 'en_US.UTF-8', 22:07:30 INFO - 'LANGUAGE': 'en_US:en', 22:07:30 INFO - 'LOGNAME': 'cltbld', 22:07:30 INFO - 'MAIL': '/var/mail/cltbld', 22:07:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:30 INFO - 'MOZ_NO_REMOTE': '1', 22:07:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:30 INFO - 'NO_EM_RESTART': '1', 22:07:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:07:30 INFO - 'SHELL': '/bin/bash', 22:07:30 INFO - 'SHLVL': '1', 22:07:30 INFO - 'TERM': 'linux', 22:07:30 INFO - 'TMOUT': '86400', 22:07:30 INFO - 'USER': 'cltbld', 22:07:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203', 22:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:30 INFO - '_': '/tools/buildbot/bin/python'} 22:07:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:07:30 INFO - mozversion application_buildid: 20160116193624 22:07:30 INFO - mozversion application_changeset: d2b4d101d00691f835c4f109524a3506d5f51626 22:07:30 INFO - mozversion application_display_name: Nightly 22:07:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:30 INFO - mozversion application_name: Firefox 22:07:30 INFO - mozversion application_remotingname: firefox 22:07:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:07:30 INFO - mozversion application_vendor: Mozilla 22:07:30 INFO - mozversion application_version: 46.0a1 22:07:30 INFO - mozversion platform_buildid: 20160116193624 22:07:30 INFO - mozversion platform_changeset: d2b4d101d00691f835c4f109524a3506d5f51626 22:07:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:07:30 INFO - mozversion platform_version: 46.0a1 22:07:30 INFO - using testdate: 1453010850 22:07:30 INFO - actual date: 1453010850 22:07:30 INFO - starting webserver on 'localhost:50350' 22:07:30 INFO - SUITE-START | Running 3 tests 22:07:30 INFO - TEST-START | dromaeo_css 22:07:30 INFO - operating with platform_type : linux_ 22:07:30 INFO - Initialising browser for dromaeo_css test... 22:07:30 INFO - TEST-INFO | started process 945 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwzHso1/profile http://localhost:50350/getInfo.html) 22:07:34 INFO - PROCESS | 945 | 22:07:34 INFO - PROCESS | 945 | (process:1033): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:07:35 INFO - PROCESS | 945 | __metrics Screen width/height:1600/1200 22:07:35 INFO - PROCESS | 945 | colorDepth:24 22:07:35 INFO - PROCESS | 945 | Browser inner width/height: 1024/697 22:07:35 INFO - PROCESS | 945 | __metrics 22:07:35 INFO - PROCESS | 945 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:07:36 INFO - TEST-INFO | 945: exit 0 22:07:36 INFO - Browser initialized. 22:07:36 INFO - Running cycle 1/1 for dromaeo_css test... 22:07:36 INFO - TEST-INFO | started process 1092 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwzHso1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:37 INFO - PROCESS | 1092 | -- checkerboarding starts below -- 22:07:37 INFO - PROCESS | 1092 | RENDERTRACE 0.043721 rect red 0 0 10 10 // viewport 22:07:37 INFO - PROCESS | 1092 | RENDERTRACE 1.34807 rect red 0 0 10 10 // viewport 22:07:37 INFO - PROCESS | 1092 | RENDERTRACE 20.2381 rect brown 0 0 10 10 // page 22:07:37 INFO - PROCESS | 1092 | RENDERTRACE 20.2616 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 22:07:37 INFO - PROCESS | 1092 | Checkerboarded for 2 frames (35.6415 ms), 100 peak, 134 severity. 22:07:37 INFO - PROCESS | 1092 | 22:07:37 INFO - PROCESS | 1092 | (process:1210): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:07:48 INFO - PROCESS | 1092 | RSS: Main: 149790720 22:07:48 INFO - PROCESS | 1092 | 22:08:37 INFO - PROCESS | 1092 | 1453010917987 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] 22:10:46 INFO - PROCESS | 1092 | Cycle 1(1): loaded http://localhost:50350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50350/tests/dromaeo/cssquery-ext.html) 22:10:47 INFO - PROCESS | 1092 | RSS: Main: 154939392 22:10:47 INFO - PROCESS | 1092 | 22:13:49 INFO - PROCESS | 1092 | Cycle 1(1): loaded http://localhost:50350/tests/dromaeo/cssquery-ext.html (next: http://localhost:50350/tests/dromaeo/cssquery-jquery.html) 22:13:50 INFO - PROCESS | 1092 | RSS: Main: 153096192 22:13:50 INFO - PROCESS | 1092 | 22:16:52 INFO - PROCESS | 1092 | Cycle 1(1): loaded http://localhost:50350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50350/tests/dromaeo/cssquery-mootools.html) 22:16:52 INFO - PROCESS | 1092 | RSS: Main: 150622208 22:16:52 INFO - PROCESS | 1092 | 22:19:54 INFO - PROCESS | 1092 | Cycle 1(1): loaded http://localhost:50350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50350/tests/dromaeo/cssquery-prototype.html) 22:19:55 INFO - PROCESS | 1092 | RSS: Main: 150519808 22:19:55 INFO - PROCESS | 1092 | 22:22:57 INFO - PROCESS | 1092 | Cycle 1(1): loaded http://localhost:50350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50350/tests/dromaeo/cssquery-yui.html) 22:22:58 INFO - PROCESS | 1092 | RSS: Main: 150700032 22:22:58 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | Cycle 1(1): loaded http://localhost:50350/tests/dromaeo/cssquery-yui.html (next: http://localhost:50350/tests/dromaeo/cssquery-dojo.html) 22:26:00 INFO - PROCESS | 1092 | RSS: Main: 153141248 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | __start_tp_report 22:26:00 INFO - PROCESS | 1092 | _x_x_mozilla_page_load 22:26:00 INFO - PROCESS | 1092 | _x_x_mozilla_page_load_details 22:26:00 INFO - PROCESS | 1092 | |i|pagename|runs| 22:26:00 INFO - PROCESS | 1092 | |0;dojo.html;3167.2715275486635;3168.6514483406836;3198.0246024962375;3242.497412901001;3246.9025929222116;5208.296879921209;5235.450277720842;5236.502532259434;5255.684658920468;5263.315768950036;5231;5238.397584277809;5315.627906046569;5328.120860058086;5358.089124848775;4588.931166032512;4834.854954351375;5036.722980236085;5038.571721403685;5044.646874718753;4834.46820849708;4948.802047918079;4984.37695288089;5003.374578177728;5021.723805190713;4783.115123702091;4812.0375924814825;4826.662133650629;4831.879203019917;4907.2639104134305;4850.054239423313;4850.466448690641;4865.3675022247235;4870.683405578661;4896.657233993622;4801.711897286139;4834.202356611155;4842.297866809328;4848.951510484921;4884.3161957326;5155.149400348938;5178.844634660929;5189.221616757479;5223.320968274138;5335.546478549328;5607.57943154261;5616.775328986836;5622.859428514279;5626.54987600995;5638.548916086745;5676.035074037423;5692.9146062809095;5694.430556944314;5699.401562835884;5706.657600543939;5319.946800531984;5369.543588794957;5396.946030539723;5402.243685883979;5446.700431476307;5783.624064435799;5823.56323275756;5832.912506312408;5850.561207909339;5867.823965281048;5548.140038294071;5602.13166959122;5603.15952607104;5611.494965453129;5638.689872056994;5598.636088654224;5697.686627235542;5729.799457018984;5744.770209191669;5757.992351338499;5704.201411802351;5726.284214473191;5726.455986681259;5726.484616384462;5735.541156707453;5596.720163991784;5666.829995100071;5730.426957304319;5739.282589676291;5750.539956803445;4373.300271956472;4399.010222699931;4449.555044495589;4465.888352791141;4511.503734589192;3956.22853543562;3957.406389041667;3960.782156981336;3972.56301806801;3997.3004724173734;5267.420583735786;5306.336707911511;5327.227552004938;5340.973295133577;5361.222622719683;5668.716564171775;5673;5704.572157088235;5713.657180569179;5757.280339957505;5251.76367063483;5305.946940530545;5310.654807437504;5311.150215965427;5316.043112239757;4784.067106914188;4853.247746599282;4858.684185527929;4872.634552408584;4892.975535122301;5830.8542286442325;5845.620034697731;5846.473817356458;5854.443827836349;5894.705264736832;5635.15472679085;5664.0937450007805;5671.064274394678;5678.2050512929045;5679.204911312502;5785.161151633074;5798.797042103506;5831.591788574929;5866.973279676125;5936.13925980739;5637.633553818989;5638.2670252866865;5639.88720225585;5642.915356269577;5643.971780141237;5606.103023516381;5694.772209111589;5700.030994730822;5713.685747283939;5720.256366672306;5482.972585137049;5548.389677135593;5555.861103472445;5589.245451863946;5631.549476041825;5444.673319600836;5448.754806033818;5468.863278417913;5471.781128754806;5491.203775452457;5394.1099718546;5404.378496472956;5439.4288599696465;5454.481824226692;5503.284573005483;5461.098918678374;5600.523955463831;5691.743871525874;5702;5744.224529688438;5388.811391601275;5449.945500545103;5451.64564303319;5457.345118585795;5471.398146203994 22:26:00 INFO - PROCESS | 1092 | |1;ext.html;530.405945341218;543.9945600543995;549.2612436273212;563.1833840930651;563.8054871069482;36794.448083278774;37313.44029839548;37570;37631.24737505252;37631.62368376315;38224.61775382245;38395.424068638924;38503.42244866322;38594.614053859455;38652.420213696816;8446.070932197468;8671.43635663683;8671.609777560025;8673.219410253107;8680.307340068657;8426.620802063891;8503;8523.147685231459;8555.272801811854;8575.356848236375;8544;8625.22372986431;8626.353023523261;8630.87053694192;8635.654573817039;8327.583620818965;8511.82976340476;8573;8579.227869491713;8590.1839325264;8385.245327920455;8561.700340488116;8572.828543429096;8592.226699597066;8598.957005214934;35620.821895890615;35971.4604280936;36059;36160.81919590385;36279.274414511565;3189.378071276102;3202.071399294202;3216.4210442120407;3230.6930841570247;3466.9945715742406;28870;29257.853710731524;29347;29408.55887161673;29712.405751885057;3870.78710670913;4007.338789099795;4021.2359651666384;4048.0689441428635;4087.97956010221;274969;275466;276856;278095;279631;57847.13229301564;58208.12687809686;58295.41704582985;58297;58342.124868127015;54471;55506.16740748892;63253;64263;64287;12756.553520626734;12806.423710932844;12867.678308042374;12891.677708057374;12919.289439080752;11253.887461125283;11299.209055366046;11324.207305488537;11347.035501982424;11354.091672666167;19349.4195174145;19522;19525.274110762468;19530.414087577396;19606.607867842562;7955.8464022717535;8131.390145739093;8135.471194372465;8170.346372290202;8276.131006244377;868.4268382867277;904.2720609908955;907.6369452219166;971.7862070344513;1000.7548150702979;25762;25926.22221333363;25934.481310373685;25988.480230395286;26092.60861087085;1029.7580068683853;1044.0812085364983;1067.0823092140752;1069.2835800014009;1093.7429704019548;13917;14064.85935140656;14381.712365752626;14424;14482.710345793024;393976.4517661187;401321;401682;401977;404065;52762.47237527652;52967.47032529626;53076;53204.733976330645;53574;1271.9554815581596;1290.748304080714;1298.6493646715335;1303.094349427139;1306.9281189534477;26418.207453776417;26998.595021074307;27244.182674519798;27447.90208391642;27474.313142171606;42198.57801421946;42633.36049959315;42906.78546607372;43029.139417210856;43113.353299699906;308618;309034;310928;311686;312245;31594.684053159173;41665;42196.36705449482;42595.36106958336;42716.78641606772;40635.390469142396;41686;41757.16485670209;41913.37129943114;42147;35018.12454688653;35210.11974700653;35212.29575408529;35863.46204806878;36047.45928811018;35336;35912.281754364245;36015.45976810298;36219.27561448704;36267.27465450729;34569.308613828085;34848.30303393969;35420;35517.467237991965;35550.64449355473;30362.240943976576;32161.517577235893;32449;32728.509072363457;32741.345173095928;24348.269551913472;24574.631380529663;24602.753972460763;24971.87514062418;25123.874380627978 22:26:00 INFO - PROCESS | 1092 | |2;jquery.html;355.3745408081775;364.8686472869766;365.9670629643333;366.47593940664854;373.57225976257206;15306.770398444032;16543.17284135793;16687.49937501874;17293.91353043236;17733.55666108348;15549.766753498707;15779.526614201592;16120.677586448264;16617.750733739005;16672.33310667572;4851.223804191339;5053.267276244942;5055.115354812911;5060.266261392115;5067.949320506803;4955.776990035457;5008.524190201943;5073.7463126843695;5411.269478620376;5414.214938833867;5058.266551350071;5248.134057880464;5269.209618557209;5388.703621300827;5389.110796718537;5204.557612602934;5215.217717342391;5232.529072383466;5243.449437809013;5546.722663866791;5249.842504724865;5286.577073834084;5298.390685071189;5306.469353064663;5310.336207974004;14046.508372207027;18898.149583268787;19522.219111235532;19624.50938726529;19643.017849107488;2004.6992951057312;2132.243053715924;2171.8045375916086;2211.231015187859;2378.488624945645;9021.864672029924;9264.166225039711;9660;9760.707178784576;12730.74538509234;1778.2353587957173;1789.185920406212;1827.3330234464458;1838.4117082533594;1867.5051111455475;56175.71912140413;56945.145822812694;57055.71472142654;57401.425985740025;58682.70658646722;9790;9944.254180936314;9973.202143828476;10068.093871551595;10130.746731331776;13169.275689836959;13175.341232938506;13206;13292.601221963356;13299.601011969657;6919.37725604698;6956.40870526011;7252.166000909963;7294.96352518234;7360.705571777176;6880.724771009203;6900.378965893094;6922.757703480454;6925.065116209247;6942.583444993316;4335.3713711511655;4406.471223453206;4411.647068234533;4426.18115648606;4434.911301773946;1717.7509261157063;1748.3356324596573;1795.0127429913496;1804.9909750451163;1829.5027287752123;864.3430992445786;880.2297989259398;908.3732224764891;935.1817159985013;988.5897352598591;15246.161461119746;15714.842851571339;15966.840331596768;16239;16409;902.6750369866843;904.2991681446799;912.4434095201922;934.2525979216599;979.4319294808994;9267.165955064076;9273.30450216223;9371.62513499466;9385;9501.90498095024;411463;411998;422930;523571;533350;44919.55080449153;45413.54586454159;46449.07101857944;56465.15302270469;68175;1111.288775183883;1124.859392575928;1132.5130194016488;1145.6906635208447;1145.7937571237258;14802.703945920806;15030.473933412279;15087.396504139711;15124.160268713906;15484.92257538705;31489.212769680023;32139.678603214605;32659.673403265664;33026.201986771826;33348.16629584183;43094.13811723685;43902.78048609736;44243.778781107176;44347.33478997882;45970.7701461504;7164.820879478055;7253.492255542062;7436.18201997769;7464;7464.440166987389;9067.818643627223;10322.948385258025;10674.89325106739;10725.678229653124;11139;9205.907940920504;9237.538123093953;9512.33413661037;9517.762055948657;9911.405315681082;9285.907140928504;9606.729506026717;9742.31803773729;10227;10490.370577765358;9585.185259253041;9655.468949207861;9690.321677482509;9766.85349719769;10185.694429167137;7087.114110736158;7204.171520275236;7337.963310183415;7388.633102875985;7431.256874312526;7818.648160832662;9869.654562090293;10008.84986725185;10083.394996300245;10165.440900750235 22:26:00 INFO - PROCESS | 1092 | |3;mootools.html;1500.887433442492;1515.7423238049535;1679.0019876347146;1792.97310540342;1804.864635152364;7618.352440042603;7734.88397674034;7817.218278172187;8019.318357939567;8071.87892181617;7892.684292628288;7935.285824275814;7974.043114826229;7981.321587665056;8000.119986801447;2308.7806658367426;2337.7662233776655;2338.567365037465;2346.718393792747;2350.3654013416367;2301.493671392291;2326.685897403854;2375.1330764271;2378.512404956988;2379.583572874749;2254.391314345126;2291.140822191678;2313.1903833658253;2313.3291345509783;2335.6730057791924;2315.0623997281045;2336.45093403051;2337.988310058439;2344.3318654183477;2347.2019513365453;2351.5296940611775;2363.326451961183;2364.7871691547844;2366.396568874943;2367.4081479630095;7798.961005194938;7856.096548896893;7858.882116768253;7885;7899.368050555941;4611.838585649486;4624.237000894848;4705.811767529295;4725.692829966076;4735.313379559944;3003.1290925631542;3021.0936718984217;3024.3346463777934;3072.09373234894;3096.5510001049947;1019.7807471393612;1030.7682319628047;1045.7647029418397;1073.978520429595;1900.1924182222501;10544.789104217873;10677.733056673567;10687.412192329419;10687.625933092382;10704.197185211062;4281.850135245251;4375.1031038637;4385.934210986838;4407.889802754893;4482.103579284156;9167.587458564381;9168.40405373662;9201.677941272023;9233.861492077624;9243.352965292364;4859.2954021667365;4865.464798872121;4871.634627402959;4920.138975679241;4921.483244259372;4423.0048239145935;4438.400815889878;4470.374147619336;4477.731336119843;4482.99132695141;3621.7826930384263;3660.2679464107287;3676.7977761223387;3717.4795528626014;3725.9068523287133;1107.7396811749231;1137.4540220694114;1148.5922497513263;1179.2983175010854;1181.7990941539958;872.5724395046509;980.8283550378655;995.4027583449872;997.8524696598824;1107.894749998749;7207.819804504825;7275.272472752682;7282.308180722823;7308.707651693979;7318.451116166202;588.3439964439705;591.7662523303271;592.7806711516766;601.6750954484529;750.1598210004829;5569.66582005081;5607.383187849333;5737.225474560881;5761.567882408836;5765.942340576625;9262.536873156316;9510;9562.426254424758;9630.27772917034;9669.226461883032;9327.486988215578;9428.245740340893;9499.28755343352;9524.190443812215;9549.331546791658;7567.394608431422;7572.39420846331;7589.051368578927;7601.6579253933705;7603.923960760432;7148;7243.311885370881;7270.563766174047;7306.4885458017425;7309.342159205697;8476.745697629081;8504.277136443225;8536.719492076238;8551.230389264996;8623.525706086226;8559;8723.78190545216;8823.69117080899;8889.19997200255;8920.464772113693;7025.68384422692;7113.679884405317;7116.395106416013;7134.8929766052515;7136.0723105995885;7476.140243872024;7502.062242219723;7700.730474433368;7717.459777815499;7719.575423351769;6867.656617169221;7238.565686058853;7248.456365772483;7383.556986580822;7389.187189409268;6826.419754320938;6882.414994725505;6914.70271563593;7019.227884932551;7171.175314838861;6991.615461149686;7019.929800701928;7032.824179395351;7077.079979602619;7092.290770922867;6524.5432819704065;6545.738170473128;6614.536982411185;6629.138212032405;6642.6014439133805;6397.200349956255;6525.771597994048;6533.542652014314;6561.3438656134;6564.310747371457 22:26:00 INFO - PROCESS | 1092 | |4;prototype.html;330.3030605422558;337.85641102531423;344.650180067232;345.5042014708892;352.7865641287023;6231.376862313772;6241.157443745093;6261.592996455227;6271.435570798633;6425.550211485198;6215.906761398583;6249.625022498642;6258.530610204241;6265.655388953605;6266.467350275232;4737.147313483571;4792.9281060784115;4796.640251981098;4798.664093513456;4800.111979283826;4791.305260737191;4797.616190704753;4799.616030717534;4800.279958006292;4803.111424386482;4505.977470112662;4663.5336466353265;4691.9765401172945;4692.108499385123;4734.218853889104;4670.369500117475;4675.696079754805;4679.110968915912;4679.204535228985;4694.178518759203;4060.9390859136843;4070.206309769596;4071.8802329359664;4080.285949958775;4087.264292427362;5857.531397488191;5863.76544938202;5867.647941123546;5902.852428689274;5918.467337939563;5370.087085195526;5435.157550579666;5469.453054694539;5482.095454250044;5489.176623506506;6581.407673309425;6587.93412065878;6588.077669126326;6590.275069742324;6603.108580341641;4473.060657261979;4487.753173575452;4500.774961251957;4513.232750432401;4513.345564893105;6676.732930682767;6851.212110607295;6889.276625954253;6934.410575101072;6956.860862782716;4548.840790572314;4559.840405585788;4568.862934111982;4570.268756998864;4584.312353146988;4591.540845915381;4616.492185859553;4625.283081122431;4637.373954516164;4648.97675511627;5397.217403476474;5411.080116380225;5422.1053526168525;5429.375621803543;5435.972820135874;6552.14822073137;6636.070950066995;6639.601623902581;6648.235452922879;6690.966545167243;1604.1257514654542;1608.2360878582579;1659.1289572974285;1659.419203278867;1667.0497816244867;1098.2916019167592;1102.9962733912262;1105.8009558279587;1107.7064577886867;1111.155521803419;6191.752329906843;6194.318624951252;6199.194104766351;6202.34875338092;6216.191895053614;6701.731930722814;6714.832129196711;6728.293529179366;6765.560238584476;6798.490113241428;6000.879982400327;6166.7224974876235;6178;6178.474829639441;6192.876142477216;3653.1415117447377;3664.5785734640326;3670.1191713988983;3674.3569875272256;3679.3745063339297;6997.545159564612;7002;7015.649217539102;7041;7042.225355211025;6750.594964302158;6899.448044156456;6955.339242771928;6963.442924566022;6968.651567421609;6987.545809522263;7013.789586312419;7032.542884712478;7039.683214255371;7040.929590704028;6704.966475167593;6714.798556043326;6717.059611654275;6724.562903411263;6728.899066514105;6536.411722944958;6619.669016549057;6667.2666006738245;6669.166354205724;6680.532362734756;7019.087518622547;7021.824454388681;7022.332878376546;7024.297570242935;7043.295670432915;4598.3102534620075;4601.792919318706;4607.93088103672;4612.630989520897;4614.884627884329;6663.533552651268;6680.298568650416;6723.731050757915;6742.9662851685425;6935.791926242221;6653.63405012729;6678.632675202716;6721.563098398588;6734.090897728744;6735.831604209738;6622.867542649216;6674.299198584079;6679;6692.297308782702;6701.262861085374;6443.581167224115;6578.5395022347975;6578.8355291118105;6580.012998050331;6586.5389422739945;6724.663766811542;6744.898826517704;6748.223954245324;6812.591244525344;6818;6513.023046543057;6515.315891831289;6523.510736694861;6534.248561415498;6535.509836762167 22:26:00 INFO - PROCESS | 1092 | |5;yui.html;824.9381296402771;825.7316372179041;825.8100636853521;828.7555171224489;848.6520526584098;12703.428345724442;12941.482340706372;12975.286359250238;12976.22142671438;12995.545155919544;11834.28994260345;12082;12097.455614497347;12155.696107597314;12196.14626976112;794.5828440068952;795.8288967871906;801.3869389916719;804.2480280937314;804.9798755031112;801.4069588504523;802.7150361621627;806.8668669669527;809.4212637963855;810.0401024785618;830.90444598871;837.1795640272506;843.2916350265775;844.4215712237107;847.8473874702551;825.9463134896242;834.6327615849037;839.1817977471977;839.2991851803752;839.8530257205026;615.129591627846;615.3139249736556;615.3999850146116;616.996915015422;617.1883972576093;13139.474421023147;13249;13254.46982120714;13263.86736132636;13320.400581973738;12655.303958282291;12700.301483418409;12889.548865789653;12894.419751111129;12957.611271661772;9770.804583908282;10646.627368042158;10769.138468922545;11113.888861111447;11183.32900026001;3481.3385456763385;3554.289142171576;3564.82175891207;3619.0771353305004;3679.5768486623847;44845.551544484464;45173.77413112946;45524;45688;45737.31394029092;9336.4864932428;9469.431834089977;9807.852882206773;9809.068138526829;10146.391216527032;17370.478885633453;17512.036837974032;17520.561985950455;17533.824661753475;17549.824501755076;6450.516211284173;6540.084388185658;6745.561538499982;6776.966115169393;6908.447324214151;4161.053734470851;4204.495460544754;4269.338252570857;4288.50682171548;4441.289393696993;3116.376724655078;3127.3745250949446;3139.984300078485;3144.261098641817;3146.5122905949156;573.8135106090454;580.0863639767383;581.3808294166699;582.0309185206668;590.10598942602;463.7426228443246;474.1441697735551;499.2336763068672;511.28164928275834;614.7203022624784;8074.677012919535;8193;8400.78998025042;8486.236238738544;8656.826863462695;460.8709561322835;502.8692539939642;569.9939606594364;574.5662025171052;577.8122110314165;3720.2745464634677;3952.091019065631;4058.7158898876796;4121.690873184523;4279.87160385189;61752.382476174665;62726.37273627296;62921.370786292464;62927.685361573815;63053;47960.28059579109;48538.5146148534;49174.262386064234;49302.50697493051;49380.50619493759;44600.553994460286;44897;44937.77531112324;45414.54585454103;45517;8438.704645337384;8564.614592343483;8568.614412351584;8640.82718345617;8793.780155496164;33684.15789605279;33796.662033379354;34138.48792268068;34998.47502287417;35348.999999998974;43450.348244776986;43757.34363984606;43886.56113438952;43935.34096988484;44851.551484484735;10601.740584275116;10717.196210284104;10746.355218686904;10886.401247931122;10984.505697243483;11689.590864319707;11842.348670822843;11978.161528692908;12068.517259309529;12254.448549815457;10507.474626268504;10563.366198028143;10579;10602.628907988183;10649.680509584725;10659.413732244491;10932.344059356146;11016.008559229707;11263.211575189986;11466.082713383075;11097.833532497181;11220.382878941737;11257.268277561932;11569.768604627692;11621.24461909973;8903.797987271635;9049.457032578066;9067.229285510806;9130.037042035994;9561.9043809561;8919.598618062073;8924.330675199515;8963.05887881763;9715.757106072404;9731.854022189531 22:26:00 INFO - PROCESS | 1092 | __end_tp_report 22:26:00 INFO - PROCESS | 1092 | __start_cc_report 22:26:00 INFO - PROCESS | 1092 | _x_x_mozilla_cycle_collect,305 22:26:00 INFO - PROCESS | 1092 | __end_cc_report 22:26:00 INFO - PROCESS | 1092 | __startTimestamp1453011960897__endTimestamp 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | ------- Summary: start ------- 22:26:00 INFO - PROCESS | 1092 | Number of tests: 6 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | [#0] dojo.html Cycles:165 Average:5286.39 Median:5451.65 stddev:569.45 (10.4%) stddev-sans-first:546.39 22:26:00 INFO - PROCESS | 1092 | Values: 3167.3 3168.7 3198.0 3242.5 3246.9 5208.3 5235.5 5236.5 5255.7 5263.3 5231.0 5238.4 5315.6 5328.1 5358.1 4588.9 4834.9 5036.7 5038.6 5044.6 4834.5 4948.8 4984.4 5003.4 5021.7 4783.1 4812.0 4826.7 4831.9 4907.3 4850.1 4850.5 4865.4 4870.7 4896.7 4801.7 4834.2 4842.3 4849.0 4884.3 5155.1 5178.8 5189.2 5223.3 5335.5 5607.6 5616.8 5622.9 5626.5 5638.5 5676.0 5692.9 5694.4 5699.4 5706.7 5319.9 5369.5 5396.9 5402.2 5446.7 5783.6 5823.6 5832.9 5850.6 5867.8 5548.1 5602.1 5603.2 5611.5 5638.7 5598.6 5697.7 5729.8 5744.8 5758.0 5704.2 5726.3 5726.5 5726.5 5735.5 5596.7 5666.8 5730.4 5739.3 5750.5 4373.3 4399.0 4449.6 4465.9 4511.5 3956.2 3957.4 3960.8 3972.6 3997.3 5267.4 5306.3 5327.2 5341.0 5361.2 5668.7 5673.0 5704.6 5713.7 5757.3 5251.8 5305.9 5310.7 5311.2 5316.0 4784.1 4853.2 4858.7 4872.6 4893.0 5830.9 5845.6 5846.5 5854.4 5894.7 5635.2 5664.1 5671.1 5678.2 5679.2 5785.2 5798.8 5831.6 5867.0 5936.1 5637.6 5638.3 5639.9 5642.9 5644.0 5606.1 5694.8 5700.0 5713.7 5720.3 5483.0 5548.4 5555.9 5589.2 5631.5 5444.7 5448.8 5468.9 5471.8 5491.2 5394.1 5404.4 5439.4 5454.5 5503.3 5461.1 5600.5 5691.7 5702.0 5744.2 5388.8 5449.9 5451.6 5457.3 5471.4 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | [#1] ext.html Cycles:180 Average:48944.13 Median:36273.27 stddev:87753.38 (241.9%) stddev-sans-first:87924.26 22:26:00 INFO - PROCESS | 1092 | Values: 530.4 544.0 549.3 563.2 563.8 36794.4 37313.4 37570.0 37631.2 37631.6 38224.6 38395.4 38503.4 38594.6 38652.4 8446.1 8671.4 8671.6 8673.2 8680.3 8426.6 8503.0 8523.1 8555.3 8575.4 8544.0 8625.2 8626.4 8630.9 8635.7 8327.6 8511.8 8573.0 8579.2 8590.2 8385.2 8561.7 8572.8 8592.2 8599.0 35620.8 35971.5 36059.0 36160.8 36279.3 3189.4 3202.1 3216.4 3230.7 3467.0 28870.0 29257.9 29347.0 29408.6 29712.4 3870.8 4007.3 4021.2 4048.1 4088.0 274969.0 275466.0 276856.0 278095.0 279631.0 57847.1 58208.1 58295.4 58297.0 58342.1 54471.0 55506.2 63253.0 64263.0 64287.0 12756.6 12806.4 12867.7 12891.7 12919.3 11253.9 11299.2 11324.2 11347.0 11354.1 19349.4 19522.0 19525.3 19530.4 19606.6 7955.8 8131.4 8135.5 8170.3 8276.1 868.4 904.3 907.6 971.8 1000.8 25762.0 25926.2 25934.5 25988.5 26092.6 1029.8 1044.1 1067.1 1069.3 1093.7 13917.0 14064.9 14381.7 14424.0 14482.7 393976.5 401321.0 401682.0 401977.0 404065.0 52762.5 52967.5 53076.0 53204.7 53574.0 1272.0 1290.7 1298.6 1303.1 1306.9 26418.2 26998.6 27244.2 27447.9 27474.3 42198.6 42633.4 42906.8 43029.1 43113.4 308618.0 309034.0 310928.0 311686.0 312245.0 31594.7 41665.0 42196.4 42595.4 42716.8 40635.4 41686.0 41757.2 41913.4 42147.0 35018.1 35210.1 35212.3 35863.5 36047.5 35336.0 35912.3 36015.5 36219.3 36267.3 34569.3 34848.3 35420.0 35517.5 35550.6 30362.2 32161.5 32449.0 32728.5 32741.3 24348.3 24574.6 24602.8 24971.9 25123.9 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | [#2] jquery.html Cycles:180 Average:24702.98 Median:4982.15 stddev:75697.57 (1519.4%) stddev-sans-first:75887.84 22:26:00 INFO - PROCESS | 1092 | Values: 355.4 364.9 366.0 366.5 373.6 15306.8 16543.2 16687.5 17293.9 17733.6 15549.8 15779.5 16120.7 16617.8 16672.3 4851.2 5053.3 5055.1 5060.3 5067.9 4955.8 5008.5 5073.7 5411.3 5414.2 5058.3 5248.1 5269.2 5388.7 5389.1 5204.6 5215.2 5232.5 5243.4 5546.7 5249.8 5286.6 5298.4 5306.5 5310.3 14046.5 18898.1 19522.2 19624.5 19643.0 2004.7 2132.2 2171.8 2211.2 2378.5 9021.9 9264.2 9660.0 9760.7 12730.7 1778.2 1789.2 1827.3 1838.4 1867.5 56175.7 56945.1 57055.7 57401.4 58682.7 9790.0 9944.3 9973.2 10068.1 10130.7 13169.3 13175.3 13206.0 13292.6 13299.6 6919.4 6956.4 7252.2 7295.0 7360.7 6880.7 6900.4 6922.8 6925.1 6942.6 4335.4 4406.5 4411.6 4426.2 4434.9 1717.8 1748.3 1795.0 1805.0 1829.5 864.3 880.2 908.4 935.2 988.6 15246.2 15714.8 15966.8 16239.0 16409.0 902.7 904.3 912.4 934.3 979.4 9267.2 9273.3 9371.6 9385.0 9501.9 411463.0 411998.0 422930.0 523571.0 533350.0 44919.6 45413.5 46449.1 56465.2 68175.0 1111.3 1124.9 1132.5 1145.7 1145.8 14802.7 15030.5 15087.4 15124.2 15484.9 31489.2 32139.7 32659.7 33026.2 33348.2 43094.1 43902.8 44243.8 44347.3 45970.8 7164.8 7253.5 7436.2 7464.0 7464.4 9067.8 10322.9 10674.9 10725.7 11139.0 9205.9 9237.5 9512.3 9517.8 9911.4 9285.9 9606.7 9742.3 10227.0 10490.4 9585.2 9655.5 9690.3 9766.9 10185.7 7087.1 7204.2 7338.0 7388.6 7431.3 7818.6 9869.7 10008.8 10083.4 10165.4 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | [#3] mootools.html Cycles:180 Average:5533.02 Median:6562.83 stddev:2875.50 (43.8%) stddev-sans-first:2867.60 22:26:00 INFO - PROCESS | 1092 | Values: 1500.9 1515.7 1679.0 1793.0 1804.9 7618.4 7734.9 7817.2 8019.3 8071.9 7892.7 7935.3 7974.0 7981.3 8000.1 2308.8 2337.8 2338.6 2346.7 2350.4 2301.5 2326.7 2375.1 2378.5 2379.6 2254.4 2291.1 2313.2 2313.3 2335.7 2315.1 2336.5 2338.0 2344.3 2347.2 2351.5 2363.3 2364.8 2366.4 2367.4 7799.0 7856.1 7858.9 7885.0 7899.4 4611.8 4624.2 4705.8 4725.7 4735.3 3003.1 3021.1 3024.3 3072.1 3096.6 1019.8 1030.8 1045.8 1074.0 1900.2 10544.8 10677.7 10687.4 10687.6 10704.2 4281.9 4375.1 4385.9 4407.9 4482.1 9167.6 9168.4 9201.7 9233.9 9243.4 4859.3 4865.5 4871.6 4920.1 4921.5 4423.0 4438.4 4470.4 4477.7 4483.0 3621.8 3660.3 3676.8 3717.5 3725.9 1107.7 1137.5 1148.6 1179.3 1181.8 872.6 980.8 995.4 997.9 1107.9 7207.8 7275.3 7282.3 7308.7 7318.5 588.3 591.8 592.8 601.7 750.2 5569.7 5607.4 5737.2 5761.6 5765.9 9262.5 9510.0 9562.4 9630.3 9669.2 9327.5 9428.2 9499.3 9524.2 9549.3 7567.4 7572.4 7589.1 7601.7 7603.9 7148.0 7243.3 7270.6 7306.5 7309.3 8476.7 8504.3 8536.7 8551.2 8623.5 8559.0 8723.8 8823.7 8889.2 8920.5 7025.7 7113.7 7116.4 7134.9 7136.1 7476.1 7502.1 7700.7 7717.5 7719.6 6867.7 7238.6 7248.5 7383.6 7389.2 6826.4 6882.4 6914.7 7019.2 7171.2 6991.6 7019.9 7032.8 7077.1 7092.3 6524.5 6545.7 6614.5 6629.1 6642.6 6397.2 6525.8 6533.5 6561.3 6564.3 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | [#4] prototype.html Cycles:180 Average:5494.69 Median:6223.78 stddev:1671.97 (26.9%) stddev-sans-first:1631.11 22:26:00 INFO - PROCESS | 1092 | Values: 330.3 337.9 344.7 345.5 352.8 6231.4 6241.2 6261.6 6271.4 6425.6 6215.9 6249.6 6258.5 6265.7 6266.5 4737.1 4792.9 4796.6 4798.7 4800.1 4791.3 4797.6 4799.6 4800.3 4803.1 4506.0 4663.5 4692.0 4692.1 4734.2 4670.4 4675.7 4679.1 4679.2 4694.2 4060.9 4070.2 4071.9 4080.3 4087.3 5857.5 5863.8 5867.6 5902.9 5918.5 5370.1 5435.2 5469.5 5482.1 5489.2 6581.4 6587.9 6588.1 6590.3 6603.1 4473.1 4487.8 4500.8 4513.2 4513.3 6676.7 6851.2 6889.3 6934.4 6956.9 4548.8 4559.8 4568.9 4570.3 4584.3 4591.5 4616.5 4625.3 4637.4 4649.0 5397.2 5411.1 5422.1 5429.4 5436.0 6552.1 6636.1 6639.6 6648.2 6691.0 1604.1 1608.2 1659.1 1659.4 1667.0 1098.3 1103.0 1105.8 1107.7 1111.2 6191.8 6194.3 6199.2 6202.3 6216.2 6701.7 6714.8 6728.3 6765.6 6798.5 6000.9 6166.7 6178.0 6178.5 6192.9 3653.1 3664.6 3670.1 3674.4 3679.4 6997.5 7002.0 7015.6 7041.0 7042.2 6750.6 6899.4 6955.3 6963.4 6968.7 6987.5 7013.8 7032.5 7039.7 7040.9 6705.0 6714.8 6717.1 6724.6 6728.9 6536.4 6619.7 6667.3 6669.2 6680.5 7019.1 7021.8 7022.3 7024.3 7043.3 4598.3 4601.8 4607.9 4612.6 4614.9 6663.5 6680.3 6723.7 6743.0 6935.8 6653.6 6678.6 6721.6 6734.1 6735.8 6622.9 6674.3 6679.0 6692.3 6701.3 6443.6 6578.5 6578.8 6580.0 6586.5 6724.7 6744.9 6748.2 6812.6 6818.0 6513.0 6515.3 6523.5 6534.2 6535.5 22:26:00 INFO - PROCESS | 1092 | 22:26:00 INFO - PROCESS | 1092 | [#5] yui.html Cycles:180 Average:13570.00 Median:45465.77 stddev:15950.86 (35.1%) stddev-sans-first:15966.89 22:26:00 INFO - PROCESS | 1092 | Values: 824.9 825.7 825.8 828.8 848.7 12703.4 12941.5 12975.3 12976.2 12995.5 11834.3 12082.0 12097.5 12155.7 12196.1 794.6 795.8 801.4 804.2 805.0 801.4 802.7 806.9 809.4 810.0 830.9 837.2 843.3 844.4 847.8 825.9 834.6 839.2 839.3 839.9 615.1 615.3 615.4 617.0 617.2 13139.5 13249.0 13254.5 13263.9 13320.4 12655.3 12700.3 12889.5 12894.4 12957.6 9770.8 10646.6 10769.1 11113.9 11183.3 3481.3 3554.3 3564.8 3619.1 3679.6 44845.6 45173.8 45524.0 45688.0 45737.3 9336.5 9469.4 9807.9 9809.1 10146.4 17370.5 17512.0 17520.6 17533.8 17549.8 6450.5 6540.1 6745.6 6777.0 6908.4 4161.1 4204.5 4269.3 4288.5 4441.3 3116.4 3127.4 3140.0 3144.3 3146.5 573.8 580.1 581.4 582.0 590.1 463.7 474.1 499.2 511.3 614.7 8074.7 8193.0 8400.8 8486.2 8656.8 460.9 502.9 570.0 574.6 577.8 3720.3 3952.1 4058.7 4121.7 4279.9 61752.4 62726.4 62921.4 62927.7 63053.0 47960.3 48538.5 49174.3 49302.5 49380.5 44600.6 44897.0 44937.8 45414.5 45517.0 8438.7 8564.6 8568.6 8640.8 8793.8 33684.2 33796.7 34138.5 34998.5 35349.0 43450.3 43757.3 43886.6 43935.3 44851.6 10601.7 10717.2 10746.4 10886.4 10984.5 11689.6 11842.3 11978.2 12068.5 12254.4 10507.5 10563.4 10579.0 10602.6 10649.7 10659.4 10932.3 11016.0 11263.2 11466.1 11097.8 11220.4 11257.3 11569.8 11621.2 8903.8 9049.5 9067.2 9130.0 9561.9 8919.6 8924.3 8963.1 9715.8 9731.9 22:26:00 INFO - PROCESS | 1092 | -------- Summary: end -------- 22:26:00 INFO - PROCESS | 1092 | 22:26:01 INFO - TEST-INFO | 1092: exit 0 22:26:01 INFO - TEST-OK | dromaeo_css | took 1110650ms 22:26:01 INFO - TEST-START | kraken 22:26:01 INFO - operating with platform_type : linux_ 22:26:01 INFO - Initialising browser for kraken test... 22:26:01 INFO - TEST-INFO | started process 1408 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8SqPYB/profile http://localhost:50350/getInfo.html) 22:26:05 INFO - PROCESS | 1408 | 22:26:05 INFO - PROCESS | 1408 | (process:1481): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:26:06 INFO - PROCESS | 1408 | __metrics Screen width/height:1600/1200 22:26:06 INFO - PROCESS | 1408 | colorDepth:24 22:26:06 INFO - PROCESS | 1408 | Browser inner width/height: 1024/697 22:26:06 INFO - PROCESS | 1408 | __metrics 22:26:06 INFO - PROCESS | 1408 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:26:07 INFO - TEST-INFO | 1408: exit 0 22:26:07 INFO - Browser initialized. 22:26:07 INFO - Running cycle 1/1 for kraken test... 22:26:07 INFO - TEST-INFO | started process 1530 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8SqPYB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:07 INFO - PROCESS | 1530 | -- checkerboarding starts below -- 22:26:07 INFO - PROCESS | 1530 | RENDERTRACE 0.047499 rect red 0 0 10 10 // viewport 22:26:07 INFO - PROCESS | 1530 | RENDERTRACE 34.9585 rect brown 0 0 10 10 // page 22:26:07 INFO - PROCESS | 1530 | RENDERTRACE 34.9809 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 22:26:07 INFO - PROCESS | 1530 | Checkerboarded for 1 frames (50.4389 ms), 100 peak, 1 severity. 22:26:08 INFO - PROCESS | 1530 | 22:26:08 INFO - PROCESS | 1530 | (process:1589): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:26:18 INFO - PROCESS | 1530 | RSS: Main: 149954560 22:26:18 INFO - PROCESS | 1530 | 22:26:21 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50350/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:21 INFO - PROCESS | 1530 | RSS: Main: 150626304 22:26:21 INFO - PROCESS | 1530 | 22:26:24 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50350/tests/kraken/driver.html?testName=audio-dft) 22:26:25 INFO - PROCESS | 1530 | RSS: Main: 152981504 22:26:25 INFO - PROCESS | 1530 | 22:26:27 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50350/tests/kraken/driver.html?testName=audio-fft) 22:26:28 INFO - PROCESS | 1530 | RSS: Main: 147394560 22:26:28 INFO - PROCESS | 1530 | 22:26:30 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50350/tests/kraken/driver.html?testName=audio-oscillator) 22:26:31 INFO - PROCESS | 1530 | RSS: Main: 147451904 22:26:31 INFO - PROCESS | 1530 | 22:26:33 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:33 INFO - PROCESS | 1530 | RSS: Main: 147914752 22:26:33 INFO - PROCESS | 1530 | 22:26:36 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50350/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:37 INFO - PROCESS | 1530 | RSS: Main: 148242432 22:26:37 INFO - PROCESS | 1530 | 22:26:40 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50350/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:41 INFO - PROCESS | 1530 | RSS: Main: 147996672 22:26:41 INFO - PROCESS | 1530 | 22:26:44 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50350/tests/kraken/driver.html?testName=json-parse-financial) 22:26:44 INFO - PROCESS | 1530 | RSS: Main: 150925312 22:26:44 INFO - PROCESS | 1530 | 22:26:46 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:26:47 INFO - PROCESS | 1530 | RSS: Main: 151166976 22:26:47 INFO - PROCESS | 1530 | 22:26:48 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:26:49 INFO - PROCESS | 1530 | RSS: Main: 150523904 22:26:49 INFO - PROCESS | 1530 | 22:26:51 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:26:52 INFO - PROCESS | 1530 | RSS: Main: 151248896 22:26:52 INFO - PROCESS | 1530 | 22:26:54 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:26:55 INFO - PROCESS | 1530 | RSS: Main: 151711744 22:26:55 INFO - PROCESS | 1530 | 22:26:57 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:26:58 INFO - PROCESS | 1530 | RSS: Main: 150704128 22:26:58 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | Cycle 1(1): loaded http://localhost:50350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50350/tests/kraken/driver.html?testName=ai-astar) 22:27:00 INFO - PROCESS | 1530 | RSS: Main: 150953984 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | __start_tp_report 22:27:00 INFO - PROCESS | 1530 | _x_x_mozilla_page_load 22:27:00 INFO - PROCESS | 1530 | _x_x_mozilla_page_load_details 22:27:00 INFO - PROCESS | 1530 | |i|pagename|runs| 22:27:00 INFO - PROCESS | 1530 | |0;ai-astar;113;107;111;110;111;123;111;112;111;110 22:27:00 INFO - PROCESS | 1530 | |1;audio-beat-detection;151;124;158;160;124;154;165;128;161;128 22:27:00 INFO - PROCESS | 1530 | |2;audio-dft;161;162;161;159;162;162;160;165;172;162 22:27:00 INFO - PROCESS | 1530 | |3;audio-fft;74;73;72;81;73;71;140;71;74;73 22:27:00 INFO - PROCESS | 1530 | |4;audio-oscillator;96;98;143;96;97;97;143;106;97;136 22:27:00 INFO - PROCESS | 1530 | |5;imaging-gaussian-blur;110;110;110;109;110;110;109;110;109;109 22:27:00 INFO - PROCESS | 1530 | |6;imaging-darkroom;146;146;146;146;146;147;147;147;146;146 22:27:00 INFO - PROCESS | 1530 | |7;imaging-desaturate;96;96;97;97;97;97;96;96;96;96 22:27:00 INFO - PROCESS | 1530 | |8;json-parse-financial;63;62;62;61;61;62;60;61;72;58 22:27:00 INFO - PROCESS | 1530 | |9;json-stringify-tinderbox;68;69;68;69;69;70;71;68;68;68 22:27:00 INFO - PROCESS | 1530 | |10;stanford-crypto-aes;82;79;91;85;84;83;81;82;82;82 22:27:00 INFO - PROCESS | 1530 | |11;stanford-crypto-ccm;114;115;126;137;120;116;115;125;121;118 22:27:00 INFO - PROCESS | 1530 | |12;stanford-crypto-pbkdf2;131;139;143;132;135;128;152;138;131;140 22:27:00 INFO - PROCESS | 1530 | |13;stanford-crypto-sha256-iterative;68;66;69;67;68;66;68;65;68;71 22:27:00 INFO - PROCESS | 1530 | __end_tp_report 22:27:00 INFO - PROCESS | 1530 | __start_cc_report 22:27:00 INFO - PROCESS | 1530 | _x_x_mozilla_cycle_collect,752 22:27:00 INFO - PROCESS | 1530 | __end_cc_report 22:27:00 INFO - PROCESS | 1530 | __startTimestamp1453012020284__endTimestamp 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | ------- Summary: start ------- 22:27:00 INFO - PROCESS | 1530 | Number of tests: 14 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.20 (3.8%) stddev-sans-first:4.44 22:27:00 INFO - PROCESS | 1530 | Values: 113.0 107.0 111.0 110.0 111.0 123.0 111.0 112.0 111.0 110.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:156.00 stddev:17.08 (10.9%) stddev-sans-first:17.99 22:27:00 INFO - PROCESS | 1530 | Values: 151.0 124.0 158.0 160.0 124.0 154.0 165.0 128.0 161.0 128.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:3.66 (2.3%) stddev-sans-first:3.83 22:27:00 INFO - PROCESS | 1530 | Values: 161.0 162.0 161.0 159.0 162.0 162.0 160.0 165.0 172.0 162.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:21.20 (29.0%) stddev-sans-first:22.37 22:27:00 INFO - PROCESS | 1530 | Values: 74.0 73.0 72.0 81.0 73.0 71.0 140.0 71.0 74.0 73.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.50 stddev:20.83 (21.6%) stddev-sans-first:21.38 22:27:00 INFO - PROCESS | 1530 | Values: 96.0 98.0 143.0 96.0 97.0 97.0 143.0 106.0 97.0 136.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:27:00 INFO - PROCESS | 1530 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:27:00 INFO - PROCESS | 1530 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:27:00 INFO - PROCESS | 1530 | Values: 96.0 96.0 97.0 97.0 97.0 97.0 96.0 96.0 96.0 96.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:3.71 (6.0%) stddev-sans-first:3.92 22:27:00 INFO - PROCESS | 1530 | Values: 63.0 62.0 62.0 61.0 61.0 62.0 60.0 61.0 72.0 58.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 22:27:00 INFO - PROCESS | 1530 | Values: 68.0 69.0 68.0 69.0 69.0 70.0 71.0 68.0 68.0 68.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:3.21 (3.9%) stddev-sans-first:3.38 22:27:00 INFO - PROCESS | 1530 | Values: 82.0 79.0 91.0 85.0 84.0 83.0 81.0 82.0 82.0 82.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:120.50 stddev:7.09 (5.9%) stddev-sans-first:7.09 22:27:00 INFO - PROCESS | 1530 | Values: 114.0 115.0 126.0 137.0 120.0 116.0 115.0 125.0 121.0 118.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:138.50 stddev:7.13 (5.1%) stddev-sans-first:7.23 22:27:00 INFO - PROCESS | 1530 | Values: 131.0 139.0 143.0 132.0 135.0 128.0 152.0 138.0 131.0 140.0 22:27:00 INFO - PROCESS | 1530 | 22:27:00 INFO - PROCESS | 1530 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.71 (2.5%) stddev-sans-first:1.81 22:27:00 INFO - PROCESS | 1530 | Values: 68.0 66.0 69.0 67.0 68.0 66.0 68.0 65.0 68.0 71.0 22:27:00 INFO - PROCESS | 1530 | -------- Summary: end -------- 22:27:00 INFO - PROCESS | 1530 | 22:27:01 INFO - TEST-INFO | 1530: exit 0 22:27:01 INFO - TEST-OK | kraken | took 59602ms 22:27:01 INFO - TEST-START | v8_7 22:27:01 INFO - operating with platform_type : linux_ 22:27:01 INFO - Initialising browser for v8_7 test... 22:27:01 INFO - TEST-INFO | started process 1817 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH02t54/profile http://localhost:50350/getInfo.html) 22:27:04 INFO - PROCESS | 1817 | 22:27:04 INFO - PROCESS | 1817 | (process:1890): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:27:05 INFO - PROCESS | 1817 | __metrics Screen width/height:1600/1200 22:27:05 INFO - PROCESS | 1817 | colorDepth:24 22:27:05 INFO - PROCESS | 1817 | Browser inner width/height: 1024/697 22:27:05 INFO - PROCESS | 1817 | __metrics 22:27:05 INFO - PROCESS | 1817 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:27:06 INFO - TEST-INFO | 1817: exit 0 22:27:06 INFO - Browser initialized. 22:27:06 INFO - Running cycle 1/1 for v8_7 test... 22:27:06 INFO - TEST-INFO | started process 1939 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH02t54/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:07 INFO - PROCESS | 1939 | -- checkerboarding starts below -- 22:27:07 INFO - PROCESS | 1939 | RENDERTRACE 0.046274 rect red 0 0 10 10 // viewport 22:27:07 INFO - PROCESS | 1939 | RENDERTRACE 41.5877 rect brown 0 0 10 10 // page 22:27:07 INFO - PROCESS | 1939 | RENDERTRACE 41.6102 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 22:27:07 INFO - PROCESS | 1939 | Checkerboarded for 1 frames (49.2154 ms), 100 peak, 1 severity. 22:27:07 INFO - PROCESS | 1939 | 22:27:07 INFO - PROCESS | 1939 | (process:1999): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:27:18 INFO - PROCESS | 1939 | RSS: Main: 150552576 22:27:18 INFO - PROCESS | 1939 | 22:27:40 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50350/tests/v8_7/run.html (next: http://localhost:50350/tests/v8_7/run.html) 22:27:41 INFO - PROCESS | 1939 | RSS: Main: 145911808 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | __start_tp_report 22:27:41 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 22:27:41 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 22:27:41 INFO - PROCESS | 1939 | |i|pagename|runs| 22:27:41 INFO - PROCESS | 1939 | |0;Richards;166.08536787908986 22:27:41 INFO - PROCESS | 1939 | |1;DeltaBlue;188.32391713747646 22:27:41 INFO - PROCESS | 1939 | |2;Encrypt;279.2516056967328 22:27:41 INFO - PROCESS | 1939 | |3;Decrypt;5213.541666666667 22:27:41 INFO - PROCESS | 1939 | |4;RayTrace;1083.4236186348862 22:27:41 INFO - PROCESS | 1939 | |5;Earley;712.4555160142348 22:27:41 INFO - PROCESS | 1939 | |6;Boyer;12329.268292682927 22:27:41 INFO - PROCESS | 1939 | |7;RegExp;41020 22:27:41 INFO - PROCESS | 1939 | |8;Splay;647.2491909385113 22:27:41 INFO - PROCESS | 1939 | |9;NavierStokes;4840.579710144928 22:27:41 INFO - PROCESS | 1939 | __end_tp_report 22:27:41 INFO - PROCESS | 1939 | __startTimestamp1453012061172__endTimestamp 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | ------- Summary: start ------- 22:27:41 INFO - PROCESS | 1939 | Number of tests: 10 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 166.1 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#1] DeltaBlue Cycles:1 Average:188.32 Median:188.32 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 188.3 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 279.3 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 5213.5 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#4] RayTrace Cycles:1 Average:1083.42 Median:1083.42 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 1083.4 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#5] Earley Cycles:1 Average:712.46 Median:712.46 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 712.5 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 12329.3 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#7] RegExp Cycles:1 Average:41020.00 Median:41020.00 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 41020.0 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#8] Splay Cycles:1 Average:647.25 Median:647.25 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 647.2 22:27:41 INFO - PROCESS | 1939 | 22:27:41 INFO - PROCESS | 1939 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:27:41 INFO - PROCESS | 1939 | Values: 4840.6 22:27:41 INFO - PROCESS | 1939 | -------- Summary: end -------- 22:27:41 INFO - PROCESS | 1939 | 22:27:42 INFO - TEST-INFO | 1939: exit 0 22:27:42 INFO - TEST-OK | v8_7 | took 40870ms 22:27:42 INFO - SUITE-END | took 1211s 22:27:42 INFO - Completed test suite (00:20:11) 22:27:42 INFO - Working with test: dromaeo_css 22:27:42 INFO - Generating results file: dromaeo_css 22:27:42 INFO - Working with test: kraken 22:27:42 INFO - Generating results file: kraken 22:27:42 INFO - javascript benchmark 22:27:42 INFO - Working with test: v8_7 22:27:42 INFO - Generating results file: v8_7 22:27:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:27:42 INFO - process_Request line: dromaeo_css 6859.83 graph.html#tests=[[72,63,43]] 22:27:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:42 INFO - process_Request line: kraken 1502.50 graph.html#tests=[[232,63,43]] 22:27:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:42 INFO - process_Request line: v8_7 20208.01 graph.html#tests=[[230,63,43]] 22:27:42 INFO - RETURN: dromaeo_css: 6859.83 22:27:42 INFO - RETURN: kraken: 1502.50 22:27:42 INFO - RETURN: v8_7: 20208.01 22:27:42 INFO - javascript benchmark 22:27:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3167.2715275486635, 3168.6514483406836, 3198.0246024962375, 3242.497412901001, 3246.9025929222116, 5208.296879921209, 5235.450277720842, 5236.502532259434, 5255.684658920468, 5263.315768950036, 5231.0, 5238.397584277809, 5315.627906046569, 5328.120860058086, 5358.089124848775, 4588.931166032512, 4834.854954351375, 5036.722980236085, 5038.571721403685, 5044.646874718753, 4834.46820849708, 4948.802047918079, 4984.37695288089, 5003.374578177728, 5021.723805190713, 4783.115123702091, 4812.0375924814825, 4826.662133650629, 4831.879203019917, 4907.2639104134305, 4850.054239423313, 4850.466448690641, 4865.3675022247235, 4870.683405578661, 4896.657233993622, 4801.711897286139, 4834.202356611155, 4842.297866809328, 4848.951510484921, 4884.3161957326, 5155.149400348938, 5178.844634660929, 5189.221616757479, 5223.320968274138, 5335.546478549328, 5607.57943154261, 5616.775328986836, 5622.859428514279, 5626.54987600995, 5638.548916086745, 5676.035074037423, 5692.9146062809095, 5694.430556944314, 5699.401562835884, 5706.657600543939, 5319.946800531984, 5369.543588794957, 5396.946030539723, 5402.243685883979, 5446.700431476307, 5783.624064435799, 5823.56323275756, 5832.912506312408, 5850.561207909339, 5867.823965281048, 5548.140038294071, 5602.13166959122, 5603.15952607104, 5611.494965453129, 5638.689872056994, 5598.636088654224, 5697.686627235542, 5729.799457018984, 5744.770209191669, 5757.992351338499, 5704.201411802351, 5726.284214473191, 5726.455986681259, 5726.484616384462, 5735.541156707453, 5596.720163991784, 5666.829995100071, 5730.426957304319, 5739.282589676291, 5750.539956803445, 4373.300271956472, 4399.010222699931, 4449.555044495589, 4465.888352791141, 4511.503734589192, 3956.22853543562, 3957.406389041667, 3960.782156981336, 3972.56301806801, 3997.3004724173734, 5267.420583735786, 5306.336707911511, 5327.227552004938, 5340.973295133577, 5361.222622719683, 5668.716564171775, 5673.0, 5704.572157088235, 5713.657180569179, 5757.280339957505, 5251.76367063483, 5305.946940530545, 5310.654807437504, 5311.150215965427, 5316.043112239757, 4784.067106914188, 4853.247746599282, 4858.684185527929, 4872.634552408584, 4892.975535122301, 5830.8542286442325, 5845.620034697731, 5846.473817356458, 5854.443827836349, 5894.705264736832, 5635.15472679085, 5664.0937450007805, 5671.064274394678, 5678.2050512929045, 5679.204911312502, 5785.161151633074, 5798.797042103506, 5831.591788574929, 5866.973279676125, 5936.13925980739, 5637.633553818989, 5638.2670252866865, 5639.88720225585, 5642.915356269577, 5643.971780141237, 5606.103023516381, 5694.772209111589, 5700.030994730822, 5713.685747283939, 5720.256366672306, 5482.972585137049, 5548.389677135593, 5555.861103472445, 5589.245451863946, 5631.549476041825, 5444.673319600836, 5448.754806033818, 5468.863278417913, 5471.781128754806, 5491.203775452457, 5394.1099718546, 5404.378496472956, 5439.4288599696465, 5454.481824226692, 5503.284573005483, 5461.098918678374, 5600.523955463831, 5691.743871525874, 5702.0, 5744.224529688438, 5388.811391601275, 5449.945500545103, 5451.64564303319, 5457.345118585795, 5471.398146203994], "unit": "score", "name": "dojo.html", "value": 5250.569654305832}, {"lowerIsBetter": false, "replicates": [530.405945341218, 543.9945600543995, 549.2612436273212, 563.1833840930651, 563.8054871069482, 36794.448083278774, 37313.44029839548, 37570.0, 37631.24737505252, 37631.62368376315, 38224.61775382245, 38395.424068638924, 38503.42244866322, 38594.614053859455, 38652.420213696816, 8446.070932197468, 8671.43635663683, 8671.609777560025, 8673.219410253107, 8680.307340068657, 8426.620802063891, 8503.0, 8523.147685231459, 8555.272801811854, 8575.356848236375, 8544.0, 8625.22372986431, 8626.353023523261, 8630.87053694192, 8635.654573817039, 8327.583620818965, 8511.82976340476, 8573.0, 8579.227869491713, 8590.1839325264, 8385.245327920455, 8561.700340488116, 8572.828543429096, 8592.226699597066, 8598.957005214934, 35620.821895890615, 35971.4604280936, 36059.0, 36160.81919590385, 36279.274414511565, 3189.378071276102, 3202.071399294202, 3216.4210442120407, 3230.6930841570247, 3466.9945715742406, 28870.0, 29257.853710731524, 29347.0, 29408.55887161673, 29712.405751885057, 3870.78710670913, 4007.338789099795, 4021.2359651666384, 4048.0689441428635, 4087.97956010221, 274969.0, 275466.0, 276856.0, 278095.0, 279631.0, 57847.13229301564, 58208.12687809686, 58295.41704582985, 58297.0, 58342.124868127015, 54471.0, 55506.16740748892, 63253.0, 64263.0, 64287.0, 12756.553520626734, 12806.423710932844, 12867.678308042374, 12891.677708057374, 12919.289439080752, 11253.887461125283, 11299.209055366046, 11324.207305488537, 11347.035501982424, 11354.091672666167, 19349.4195174145, 19522.0, 19525.274110762468, 19530.414087577396, 19606.607867842562, 7955.8464022717535, 8131.390145739093, 8135.471194372465, 8170.346372290202, 8276.131006244377, 868.4268382867277, 904.2720609908955, 907.6369452219166, 971.7862070344513, 1000.7548150702979, 25762.0, 25926.22221333363, 25934.481310373685, 25988.480230395286, 26092.60861087085, 1029.7580068683853, 1044.0812085364983, 1067.0823092140752, 1069.2835800014009, 1093.7429704019548, 13917.0, 14064.85935140656, 14381.712365752626, 14424.0, 14482.710345793024, 393976.4517661187, 401321.0, 401682.0, 401977.0, 404065.0, 52762.47237527652, 52967.47032529626, 53076.0, 53204.733976330645, 53574.0, 1271.9554815581596, 1290.748304080714, 1298.6493646715335, 1303.094349427139, 1306.9281189534477, 26418.207453776417, 26998.595021074307, 27244.182674519798, 27447.90208391642, 27474.313142171606, 42198.57801421946, 42633.36049959315, 42906.78546607372, 43029.139417210856, 43113.353299699906, 308618.0, 309034.0, 310928.0, 311686.0, 312245.0, 31594.684053159173, 41665.0, 42196.36705449482, 42595.36106958336, 42716.78641606772, 40635.390469142396, 41686.0, 41757.16485670209, 41913.37129943114, 42147.0, 35018.12454688653, 35210.11974700653, 35212.29575408529, 35863.46204806878, 36047.45928811018, 35336.0, 35912.281754364245, 36015.45976810298, 36219.27561448704, 36267.27465450729, 34569.308613828085, 34848.30303393969, 35420.0, 35517.467237991965, 35550.64449355473, 30362.240943976576, 32161.517577235893, 32449.0, 32728.509072363457, 32741.345173095928, 24348.269551913472, 24574.631380529663, 24602.753972460763, 24971.87514062418, 25123.874380627978], "unit": "score", "name": "ext.html", "value": 18229.363030452936}, {"lowerIsBetter": false, "replicates": [355.3745408081775, 364.8686472869766, 365.9670629643333, 366.47593940664854, 373.57225976257206, 15306.770398444032, 16543.17284135793, 16687.49937501874, 17293.91353043236, 17733.55666108348, 15549.766753498707, 15779.526614201592, 16120.677586448264, 16617.750733739005, 16672.33310667572, 4851.223804191339, 5053.267276244942, 5055.115354812911, 5060.266261392115, 5067.949320506803, 4955.776990035457, 5008.524190201943, 5073.7463126843695, 5411.269478620376, 5414.214938833867, 5058.266551350071, 5248.134057880464, 5269.209618557209, 5388.703621300827, 5389.110796718537, 5204.557612602934, 5215.217717342391, 5232.529072383466, 5243.449437809013, 5546.722663866791, 5249.842504724865, 5286.577073834084, 5298.390685071189, 5306.469353064663, 5310.336207974004, 14046.508372207027, 18898.149583268787, 19522.219111235532, 19624.50938726529, 19643.017849107488, 2004.6992951057312, 2132.243053715924, 2171.8045375916086, 2211.231015187859, 2378.488624945645, 9021.864672029924, 9264.166225039711, 9660.0, 9760.707178784576, 12730.74538509234, 1778.2353587957173, 1789.185920406212, 1827.3330234464458, 1838.4117082533594, 1867.5051111455475, 56175.71912140413, 56945.145822812694, 57055.71472142654, 57401.425985740025, 58682.70658646722, 9790.0, 9944.254180936314, 9973.202143828476, 10068.093871551595, 10130.746731331776, 13169.275689836959, 13175.341232938506, 13206.0, 13292.601221963356, 13299.601011969657, 6919.37725604698, 6956.40870526011, 7252.166000909963, 7294.96352518234, 7360.705571777176, 6880.724771009203, 6900.378965893094, 6922.757703480454, 6925.065116209247, 6942.583444993316, 4335.3713711511655, 4406.471223453206, 4411.647068234533, 4426.18115648606, 4434.911301773946, 1717.7509261157063, 1748.3356324596573, 1795.0127429913496, 1804.9909750451163, 1829.5027287752123, 864.3430992445786, 880.2297989259398, 908.3732224764891, 935.1817159985013, 988.5897352598591, 15246.161461119746, 15714.842851571339, 15966.840331596768, 16239.0, 16409.0, 902.6750369866843, 904.2991681446799, 912.4434095201922, 934.2525979216599, 979.4319294808994, 9267.165955064076, 9273.30450216223, 9371.62513499466, 9385.0, 9501.90498095024, 411463.0, 411998.0, 422930.0, 523571.0, 533350.0, 44919.55080449153, 45413.54586454159, 46449.07101857944, 56465.15302270469, 68175.0, 1111.288775183883, 1124.859392575928, 1132.5130194016488, 1145.6906635208447, 1145.7937571237258, 14802.703945920806, 15030.473933412279, 15087.396504139711, 15124.160268713906, 15484.92257538705, 31489.212769680023, 32139.678603214605, 32659.673403265664, 33026.201986771826, 33348.16629584183, 43094.13811723685, 43902.78048609736, 44243.778781107176, 44347.33478997882, 45970.7701461504, 7164.820879478055, 7253.492255542062, 7436.18201997769, 7464.0, 7464.440166987389, 9067.818643627223, 10322.948385258025, 10674.89325106739, 10725.678229653124, 11139.0, 9205.907940920504, 9237.538123093953, 9512.33413661037, 9517.762055948657, 9911.405315681082, 9285.907140928504, 9606.729506026717, 9742.31803773729, 10227.0, 10490.370577765358, 9585.185259253041, 9655.468949207861, 9690.321677482509, 9766.85349719769, 10185.694429167137, 7087.114110736158, 7204.171520275236, 7337.963310183415, 7388.633102875985, 7431.256874312526, 7818.648160832662, 9869.654562090293, 10008.84986725185, 10083.394996300245, 10165.440900750235], "unit": "score", "name": "jquery.html", "value": 7981.95979283004}, {"lowerIsBetter": false, "replicates": [1500.887433442492, 1515.7423238049535, 1679.0019876347146, 1792.97310540342, 1804.864635152364, 7618.352440042603, 7734.88397674034, 7817.218278172187, 8019.318357939567, 8071.87892181617, 7892.684292628288, 7935.285824275814, 7974.043114826229, 7981.321587665056, 8000.119986801447, 2308.7806658367426, 2337.7662233776655, 2338.567365037465, 2346.718393792747, 2350.3654013416367, 2301.493671392291, 2326.685897403854, 2375.1330764271, 2378.512404956988, 2379.583572874749, 2254.391314345126, 2291.140822191678, 2313.1903833658253, 2313.3291345509783, 2335.6730057791924, 2315.0623997281045, 2336.45093403051, 2337.988310058439, 2344.3318654183477, 2347.2019513365453, 2351.5296940611775, 2363.326451961183, 2364.7871691547844, 2366.396568874943, 2367.4081479630095, 7798.961005194938, 7856.096548896893, 7858.882116768253, 7885.0, 7899.368050555941, 4611.838585649486, 4624.237000894848, 4705.811767529295, 4725.692829966076, 4735.313379559944, 3003.1290925631542, 3021.0936718984217, 3024.3346463777934, 3072.09373234894, 3096.5510001049947, 1019.7807471393612, 1030.7682319628047, 1045.7647029418397, 1073.978520429595, 1900.1924182222501, 10544.789104217873, 10677.733056673567, 10687.412192329419, 10687.625933092382, 10704.197185211062, 4281.850135245251, 4375.1031038637, 4385.934210986838, 4407.889802754893, 4482.103579284156, 9167.587458564381, 9168.40405373662, 9201.677941272023, 9233.861492077624, 9243.352965292364, 4859.2954021667365, 4865.464798872121, 4871.634627402959, 4920.138975679241, 4921.483244259372, 4423.0048239145935, 4438.400815889878, 4470.374147619336, 4477.731336119843, 4482.99132695141, 3621.7826930384263, 3660.2679464107287, 3676.7977761223387, 3717.4795528626014, 3725.9068523287133, 1107.7396811749231, 1137.4540220694114, 1148.5922497513263, 1179.2983175010854, 1181.7990941539958, 872.5724395046509, 980.8283550378655, 995.4027583449872, 997.8524696598824, 1107.894749998749, 7207.819804504825, 7275.272472752682, 7282.308180722823, 7308.707651693979, 7318.451116166202, 588.3439964439705, 591.7662523303271, 592.7806711516766, 601.6750954484529, 750.1598210004829, 5569.66582005081, 5607.383187849333, 5737.225474560881, 5761.567882408836, 5765.942340576625, 9262.536873156316, 9510.0, 9562.426254424758, 9630.27772917034, 9669.226461883032, 9327.486988215578, 9428.245740340893, 9499.28755343352, 9524.190443812215, 9549.331546791658, 7567.394608431422, 7572.39420846331, 7589.051368578927, 7601.6579253933705, 7603.923960760432, 7148.0, 7243.311885370881, 7270.563766174047, 7306.4885458017425, 7309.342159205697, 8476.745697629081, 8504.277136443225, 8536.719492076238, 8551.230389264996, 8623.525706086226, 8559.0, 8723.78190545216, 8823.69117080899, 8889.19997200255, 8920.464772113693, 7025.68384422692, 7113.679884405317, 7116.395106416013, 7134.8929766052515, 7136.0723105995885, 7476.140243872024, 7502.062242219723, 7700.730474433368, 7717.459777815499, 7719.575423351769, 6867.656617169221, 7238.565686058853, 7248.456365772483, 7383.556986580822, 7389.187189409268, 6826.419754320938, 6882.414994725505, 6914.70271563593, 7019.227884932551, 7171.175314838861, 6991.615461149686, 7019.929800701928, 7032.824179395351, 7077.079979602619, 7092.290770922867, 6524.5432819704065, 6545.738170473128, 6614.536982411185, 6629.138212032405, 6642.6014439133805, 6397.200349956255, 6525.771597994048, 6533.542652014314, 6561.3438656134, 6564.310747371457], "unit": "score", "name": "mootools.html", "value": 4492.365214196722}, {"lowerIsBetter": false, "replicates": [330.3030605422558, 337.85641102531423, 344.650180067232, 345.5042014708892, 352.7865641287023, 6231.376862313772, 6241.157443745093, 6261.592996455227, 6271.435570798633, 6425.550211485198, 6215.906761398583, 6249.625022498642, 6258.530610204241, 6265.655388953605, 6266.467350275232, 4737.147313483571, 4792.9281060784115, 4796.640251981098, 4798.664093513456, 4800.111979283826, 4791.305260737191, 4797.616190704753, 4799.616030717534, 4800.279958006292, 4803.111424386482, 4505.977470112662, 4663.5336466353265, 4691.9765401172945, 4692.108499385123, 4734.218853889104, 4670.369500117475, 4675.696079754805, 4679.110968915912, 4679.204535228985, 4694.178518759203, 4060.9390859136843, 4070.206309769596, 4071.8802329359664, 4080.285949958775, 4087.264292427362, 5857.531397488191, 5863.76544938202, 5867.647941123546, 5902.852428689274, 5918.467337939563, 5370.087085195526, 5435.157550579666, 5469.453054694539, 5482.095454250044, 5489.176623506506, 6581.407673309425, 6587.93412065878, 6588.077669126326, 6590.275069742324, 6603.108580341641, 4473.060657261979, 4487.753173575452, 4500.774961251957, 4513.232750432401, 4513.345564893105, 6676.732930682767, 6851.212110607295, 6889.276625954253, 6934.410575101072, 6956.860862782716, 4548.840790572314, 4559.840405585788, 4568.862934111982, 4570.268756998864, 4584.312353146988, 4591.540845915381, 4616.492185859553, 4625.283081122431, 4637.373954516164, 4648.97675511627, 5397.217403476474, 5411.080116380225, 5422.1053526168525, 5429.375621803543, 5435.972820135874, 6552.14822073137, 6636.070950066995, 6639.601623902581, 6648.235452922879, 6690.966545167243, 1604.1257514654542, 1608.2360878582579, 1659.1289572974285, 1659.419203278867, 1667.0497816244867, 1098.2916019167592, 1102.9962733912262, 1105.8009558279587, 1107.7064577886867, 1111.155521803419, 6191.752329906843, 6194.318624951252, 6199.194104766351, 6202.34875338092, 6216.191895053614, 6701.731930722814, 6714.832129196711, 6728.293529179366, 6765.560238584476, 6798.490113241428, 6000.879982400327, 6166.7224974876235, 6178.0, 6178.474829639441, 6192.876142477216, 3653.1415117447377, 3664.5785734640326, 3670.1191713988983, 3674.3569875272256, 3679.3745063339297, 6997.545159564612, 7002.0, 7015.649217539102, 7041.0, 7042.225355211025, 6750.594964302158, 6899.448044156456, 6955.339242771928, 6963.442924566022, 6968.651567421609, 6987.545809522263, 7013.789586312419, 7032.542884712478, 7039.683214255371, 7040.929590704028, 6704.966475167593, 6714.798556043326, 6717.059611654275, 6724.562903411263, 6728.899066514105, 6536.411722944958, 6619.669016549057, 6667.2666006738245, 6669.166354205724, 6680.532362734756, 7019.087518622547, 7021.824454388681, 7022.332878376546, 7024.297570242935, 7043.295670432915, 4598.3102534620075, 4601.792919318706, 4607.93088103672, 4612.630989520897, 4614.884627884329, 6663.533552651268, 6680.298568650416, 6723.731050757915, 6742.9662851685425, 6935.791926242221, 6653.63405012729, 6678.632675202716, 6721.563098398588, 6734.090897728744, 6735.831604209738, 6622.867542649216, 6674.299198584079, 6679.0, 6692.297308782702, 6701.262861085374, 6443.581167224115, 6578.5395022347975, 6578.8355291118105, 6580.012998050331, 6586.5389422739945, 6724.663766811542, 6744.898826517704, 6748.223954245324, 6812.591244525344, 6818.0, 6513.023046543057, 6515.315891831289, 6523.510736694861, 6534.248561415498, 6535.509836762167], "unit": "score", "name": "prototype.html", "value": 4947.849042615775}, {"lowerIsBetter": false, "replicates": [824.9381296402771, 825.7316372179041, 825.8100636853521, 828.7555171224489, 848.6520526584098, 12703.428345724442, 12941.482340706372, 12975.286359250238, 12976.22142671438, 12995.545155919544, 11834.28994260345, 12082.0, 12097.455614497347, 12155.696107597314, 12196.14626976112, 794.5828440068952, 795.8288967871906, 801.3869389916719, 804.2480280937314, 804.9798755031112, 801.4069588504523, 802.7150361621627, 806.8668669669527, 809.4212637963855, 810.0401024785618, 830.90444598871, 837.1795640272506, 843.2916350265775, 844.4215712237107, 847.8473874702551, 825.9463134896242, 834.6327615849037, 839.1817977471977, 839.2991851803752, 839.8530257205026, 615.129591627846, 615.3139249736556, 615.3999850146116, 616.996915015422, 617.1883972576093, 13139.474421023147, 13249.0, 13254.46982120714, 13263.86736132636, 13320.400581973738, 12655.303958282291, 12700.301483418409, 12889.548865789653, 12894.419751111129, 12957.611271661772, 9770.804583908282, 10646.627368042158, 10769.138468922545, 11113.888861111447, 11183.32900026001, 3481.3385456763385, 3554.289142171576, 3564.82175891207, 3619.0771353305004, 3679.5768486623847, 44845.551544484464, 45173.77413112946, 45524.0, 45688.0, 45737.31394029092, 9336.4864932428, 9469.431834089977, 9807.852882206773, 9809.068138526829, 10146.391216527032, 17370.478885633453, 17512.036837974032, 17520.561985950455, 17533.824661753475, 17549.824501755076, 6450.516211284173, 6540.084388185658, 6745.561538499982, 6776.966115169393, 6908.447324214151, 4161.053734470851, 4204.495460544754, 4269.338252570857, 4288.50682171548, 4441.289393696993, 3116.376724655078, 3127.3745250949446, 3139.984300078485, 3144.261098641817, 3146.5122905949156, 573.8135106090454, 580.0863639767383, 581.3808294166699, 582.0309185206668, 590.10598942602, 463.7426228443246, 474.1441697735551, 499.2336763068672, 511.28164928275834, 614.7203022624784, 8074.677012919535, 8193.0, 8400.78998025042, 8486.236238738544, 8656.826863462695, 460.8709561322835, 502.8692539939642, 569.9939606594364, 574.5662025171052, 577.8122110314165, 3720.2745464634677, 3952.091019065631, 4058.7158898876796, 4121.690873184523, 4279.87160385189, 61752.382476174665, 62726.37273627296, 62921.370786292464, 62927.685361573815, 63053.0, 47960.28059579109, 48538.5146148534, 49174.262386064234, 49302.50697493051, 49380.50619493759, 44600.553994460286, 44897.0, 44937.77531112324, 45414.54585454103, 45517.0, 8438.704645337384, 8564.614592343483, 8568.614412351584, 8640.82718345617, 8793.780155496164, 33684.15789605279, 33796.662033379354, 34138.48792268068, 34998.47502287417, 35348.999999998974, 43450.348244776986, 43757.34363984606, 43886.56113438952, 43935.34096988484, 44851.551484484735, 10601.740584275116, 10717.196210284104, 10746.355218686904, 10886.401247931122, 10984.505697243483, 11689.590864319707, 11842.348670822843, 11978.161528692908, 12068.517259309529, 12254.448549815457, 10507.474626268504, 10563.366198028143, 10579.0, 10602.628907988183, 10649.680509584725, 10659.413732244491, 10932.344059356146, 11016.008559229707, 11263.211575189986, 11466.082713383075, 11097.833532497181, 11220.382878941737, 11257.268277561932, 11569.768604627692, 11621.24461909973, 8903.797987271635, 9049.457032578066, 9067.229285510806, 9130.037042035994, 9561.9043809561, 8919.598618062073, 8924.330675199515, 8963.05887881763, 9715.757106072404, 9731.854022189531], "unit": "score", "name": "yui.html", "value": 6135.718602223622}], "name": "dromaeo_css", "value": 6859.83151011088}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 110.0, 111.0, 123.0, 111.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 158.0, 160.0, 124.0, 154.0, 165.0, 128.0, 161.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 159.0, 162.0, 162.0, 160.0, 165.0, 172.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 81.0, 73.0, 71.0, 140.0, 71.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 143.0, 96.0, 97.0, 97.0, 143.0, 106.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 62.0, 61.0, 61.0, 62.0, 60.0, 61.0, 72.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 62.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 71.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 79.0, 91.0, 85.0, 84.0, 83.0, 81.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 126.0, 137.0, 120.0, 116.0, 115.0, 125.0, 121.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [131.0, 139.0, 143.0, 132.0, 135.0, 128.0, 152.0, 138.0, 131.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.9}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 69.0, 67.0, 68.0, 66.0, 68.0, 65.0, 68.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1502.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [188.32391713747646], "unit": "score", "name": "DeltaBlue", "value": 351.08658000000014}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1083.4236186348862], "unit": "score", "name": "RayTrace", "value": 683.0098469999997}, {"lowerIsBetter": false, "replicates": [712.4555160142348], "unit": "score", "name": "Earley", "value": 935.44506993007}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [41020.0], "unit": "score", "name": "RegExp", "value": 22.208313018039966}, {"lowerIsBetter": false, "replicates": [647.2491909385113], "unit": "score", "name": "Splay", "value": 125.90359500000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20208.00877511969}]} 22:27:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20208.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1502.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6859.83"}}} 22:27:42 INFO - Return code: 0 22:27:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:27:42 INFO - # TBPL SUCCESS # 22:27:42 INFO - Running post-action listener: _resource_record_post_action 22:27:42 INFO - Running post-run listener: _resource_record_post_run 22:27:43 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 28672; Write bytes: 548225024; Read time: 80; Write time: 439552 22:27:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238010368; Read time: 0; Write time: 222744 22:27:43 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 28672; Write bytes: 310214656; Read time: 80; Write time: 216808 22:27:43 INFO - Running post-run listener: _upload_blobber_files 22:27:43 INFO - Blob upload gear active. 22:27:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:27:43 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:27:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:27:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:27:44 INFO - (blobuploader) - INFO - Open directory for files ... 22:27:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:27:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:27:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:44 INFO - (blobuploader) - INFO - Done attempting. 22:27:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:27:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:27:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:45 INFO - (blobuploader) - INFO - Done attempting. 22:27:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:27:45 INFO - Return code: 0 22:27:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:27:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:27:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8b93e8b9afaf19a51240fe454ff3e72f24fcc832f7c960469b5dbb4ac28557c64a62dfafac3c8ed9a842b6452187a59f6c0c0c94db8a4e4235dcd6e5799b694", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87f8b953a8605ee62a7c9b6a2387b8d052a55354a62b10027e05437f8442807030e422cf434a35601806d73ebb437e37a8ba2f4edf37541a553248a60b97df5c"} 22:27:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:27:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:27:45 INFO - Contents: 22:27:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8b93e8b9afaf19a51240fe454ff3e72f24fcc832f7c960469b5dbb4ac28557c64a62dfafac3c8ed9a842b6452187a59f6c0c0c94db8a4e4235dcd6e5799b694", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87f8b953a8605ee62a7c9b6a2387b8d052a55354a62b10027e05437f8442807030e422cf434a35601806d73ebb437e37a8ba2f4edf37541a553248a60b97df5c"} 22:27:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:27:45 INFO - Copying logs to upload dir... 22:27:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:27:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.772357 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-16 22:27:45.601339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:45.604951) ========= 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8b93e8b9afaf19a51240fe454ff3e72f24fcc832f7c960469b5dbb4ac28557c64a62dfafac3c8ed9a842b6452187a59f6c0c0c94db8a4e4235dcd6e5799b694", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87f8b953a8605ee62a7c9b6a2387b8d052a55354a62b10027e05437f8442807030e422cf434a35601806d73ebb437e37a8ba2f4edf37541a553248a60b97df5c"} build_url:https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8b93e8b9afaf19a51240fe454ff3e72f24fcc832f7c960469b5dbb4ac28557c64a62dfafac3c8ed9a842b6452187a59f6c0c0c94db8a4e4235dcd6e5799b694", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87f8b953a8605ee62a7c9b6a2387b8d052a55354a62b10027e05437f8442807030e422cf434a35601806d73ebb437e37a8ba2f4edf37541a553248a60b97df5c"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:45.683418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:45.683818) ========= 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=836cfdc75598d54cb747368e000001a9-1453001023.959316-1840034203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:45.702509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 22:27:45.703201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 22:27:45.703870) ========= ========= Total master_lag: 0.37 =========