builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1451487950.58 results: success (0) buildid: 20151230043003 builduid: e982aa8dc22f4415914b0bffcc31bbe9 revision: c690c50b2b543b420803e8192d6e08e06b20e0a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.575881) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.576360) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.576659) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006252 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.601813) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.602178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.617445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.617752) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.666334) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.666676) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.667063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.667341) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 07:05:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.8M=0s 2015-12-30 07:05:51 (59.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179952 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.861545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.861851) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019013 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.912332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:50.912701) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c690c50b2b543b420803e8192d6e08e06b20e0a3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c690c50b2b543b420803e8192d6e08e06b20e0a3 --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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 07:05:51,148 truncating revision to first 12 chars 2015-12-30 07:05:51,148 Setting DEBUG logging. 2015-12-30 07:05:51,148 attempt 1/10 2015-12-30 07:05:51,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c690c50b2b54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 07:05:51,393 unpacking tar archive at: mozilla-central-c690c50b2b54/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:51.439719) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:51.440018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:51.454585) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:51.454832) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 07:05:51.455225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-30 07:05:51.455511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:51 INFO - MultiFileLogger online at 20151230 07:05:51 in /builds/slave/test-pgo 07:05:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:05:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:05:51 INFO - {'append_to_log': False, 07:05:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:05:51 INFO - 'blob_upload_branch': 'Firefox', 07:05:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:05:51 INFO - 'branch': 'Firefox', 07:05:51 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:51 INFO - 'config_files': ('talos/linux_config.py',), 07:05:51 INFO - 'default_actions': ('clobber', 07:05:51 INFO - 'read-buildbot-config', 07:05:51 INFO - 'download-and-extract', 07:05:51 INFO - 'populate-webroot', 07:05:51 INFO - 'create-virtualenv', 07:05:51 INFO - 'install', 07:05:51 INFO - 'run-tests'), 07:05:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:51 INFO - 'download_minidump_stackwalk': True, 07:05:51 INFO - 'download_symbols': 'ondemand', 07:05:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:51 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:51 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:51 INFO - 'installer_path': 'installer.exe', 07:05:51 INFO - 'log_level': 'info', 07:05:51 INFO - 'log_name': 'talos', 07:05:51 INFO - 'log_to_console': True, 07:05:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:51 INFO - 'opt_config_files': (), 07:05:51 INFO - 'pip_index': False, 07:05:51 INFO - 'sps_profile': False, 07:05:51 INFO - 'sps_profile_interval': 0, 07:05:51 INFO - 'suite': 'dromaeojs-e10s', 07:05:51 INFO - 'system_bits': '32', 07:05:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:51 INFO - 'title': 'talos-linux64-ix-020', 07:05:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:51 INFO - 'use_talos_json': True, 07:05:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:05:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:51 INFO - 'work_dir': 'build'} 07:05:51 INFO - ##### 07:05:51 INFO - ##### Running clobber step. 07:05:51 INFO - ##### 07:05:51 INFO - Running pre-action listener: _resource_record_pre_action 07:05:51 INFO - Running main action method: clobber 07:05:51 INFO - rmtree: /builds/slave/test-pgo/build 07:05:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:05:52 INFO - Running post-action listener: _resource_record_post_action 07:05:52 INFO - ##### 07:05:52 INFO - ##### Running read-buildbot-config step. 07:05:52 INFO - ##### 07:05:52 INFO - Running pre-action listener: _resource_record_pre_action 07:05:52 INFO - Running main action method: read_buildbot_config 07:05:52 INFO - Using buildbot properties: 07:05:52 INFO - { 07:05:52 INFO - "project": "", 07:05:52 INFO - "product": "firefox", 07:05:52 INFO - "script_repo_revision": "production", 07:05:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:05:52 INFO - "repository": "", 07:05:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:05:52 INFO - "buildid": "20151230043003", 07:05:52 INFO - "pgo_build": "True", 07:05:52 INFO - "basedir": "/builds/slave/test-pgo", 07:05:52 INFO - "buildnumber": 66, 07:05:52 INFO - "slavename": "talos-linux64-ix-020", 07:05:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:05:52 INFO - "platform": "ubuntu64_hw", 07:05:52 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:05:52 INFO - "branch": "mozilla-central", 07:05:52 INFO - "repo_path": "mozilla-central", 07:05:52 INFO - "revision": "c690c50b2b543b420803e8192d6e08e06b20e0a3", 07:05:52 INFO - "stage_platform": "linux64-pgo", 07:05:52 INFO - "builduid": "e982aa8dc22f4415914b0bffcc31bbe9", 07:05:52 INFO - "slavebuilddir": "test" 07:05:52 INFO - } 07:05:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:05:52 INFO - Running post-action listener: _resource_record_post_action 07:05:52 INFO - ##### 07:05:52 INFO - ##### Running download-and-extract step. 07:05:52 INFO - ##### 07:05:52 INFO - Running pre-action listener: _resource_record_pre_action 07:05:52 INFO - Running main action method: download_and_extract 07:05:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:05: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')]} 07:05:52 INFO - https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/test_packages.json 07:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/test_packages.json 07:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:05:52 INFO - Downloaded 1302 bytes. 07:05:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:05:52 INFO - Using the following test package requirements: 07:05:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:05:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:52 INFO - u'jsshell-linux-x86_64.zip'], 07:05:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:05:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:05:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:05:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:05:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:05:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:05: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')]} 07:05:52 INFO - https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:05:54 INFO - Downloaded 23202206 bytes. 07:05:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:05:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:05:55 INFO - Return code: 0 07:05:55 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 07:05: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')]} 07:05:55 INFO - https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:05:56 INFO - Downloaded 23202206 bytes. 07:05:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:05:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:05:57 INFO - Return code: 0 07:05: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')]} 07:05:57 INFO - https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:05:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:05:59 INFO - Downloaded 11132285 bytes. 07:05:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:05:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:05:59 INFO - Return code: 0 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:59 INFO - https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-usqy8oReKlv2V_PH1aGg/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 07:06:00 INFO - Downloaded 54935009 bytes. 07:06:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:00 INFO - mkdir: /builds/slave/test-pgo/properties 07:06:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:06:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:06:00 INFO - Contents: 07:06:00 INFO - build_url:https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:00 INFO - Running post-action listener: _resource_record_post_action 07:06:00 INFO - Running post-action listener: set_extra_try_arguments 07:06:00 INFO - ##### 07:06:00 INFO - ##### Running populate-webroot step. 07:06:00 INFO - ##### 07:06:00 INFO - Running pre-action listener: _resource_record_pre_action 07:06:00 INFO - Running main action method: populate_webroot 07:06:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:00 INFO - '--tppagecycles', 07:06:00 INFO - '7'], 07:06:00 INFO - 'tests': ['tsvgm']}}, 07:06:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:06:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:06:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:06:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'tests': ['damp', 'tps']}, 07:06:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['damp', 'tps']}, 07:06:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:06:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:00 INFO - 'other': {'tests': ['a11yr', 07:06:00 INFO - 'ts_paint', 07:06:00 INFO - 'tpaint', 07:06:00 INFO - 'sessionrestore', 07:06:00 INFO - 'sessionrestore_no_auto_restore']}, 07:06:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['a11yr', 07:06:00 INFO - 'ts_paint', 07:06:00 INFO - 'tpaint', 07:06:00 INFO - 'sessionrestore', 07:06:00 INFO - 'sessionrestore_no_auto_restore']}, 07:06:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['a11yr', 07:06:00 INFO - 'ts_paint', 07:06:00 INFO - 'tpaint', 07:06:00 INFO - 'sessionrestore', 07:06:00 INFO - 'sessionrestore_no_auto_restore']}, 07:06:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['a11yr', 07:06:00 INFO - 'ts_paint', 07:06:00 INFO - 'tpaint', 07:06:00 INFO - 'sessionrestore', 07:06:00 INFO - 'sessionrestore_no_auto_restore']}, 07:06:00 INFO - 'other_l64': {'tests': ['a11yr', 07:06:00 INFO - 'ts_paint', 07:06:00 INFO - 'tpaint', 07:06:00 INFO - 'sessionrestore', 07:06:00 INFO - 'sessionrestore_no_auto_restore']}, 07:06:00 INFO - 'other_nol64': {'tests': ['a11yr', 07:06:00 INFO - 'ts_paint', 07:06:00 INFO - 'tpaint', 07:06:00 INFO - 'sessionrestore', 07:06:00 INFO - 'sessionrestore_no_auto_restore']}, 07:06:00 INFO - 'svgr': {'tests': ['tsvgx', 07:06:00 INFO - 'tsvgr_opacity', 07:06:00 INFO - 'tart', 07:06:00 INFO - 'tscrollx', 07:06:00 INFO - 'cart']}, 07:06:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['tsvgx', 07:06:00 INFO - 'tsvgr_opacity', 07:06:00 INFO - 'tart', 07:06:00 INFO - 'tscrollx', 07:06:00 INFO - 'cart']}, 07:06:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'tests': ['tp5o']}, 07:06:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'talos_options': ['--e10s'], 07:06:00 INFO - 'tests': ['tp5o']}, 07:06:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'talos_options': ['--xperf_path', 07:06:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:00 INFO - 'tests': ['tp5n']}, 07:06:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:00 INFO - 'talos_options': ['--e10s', 07:06:00 INFO - '--xperf_path', 07:06:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:00 INFO - 'tests': ['tp5n']}}, 07:06:00 INFO - 'talos.zip': {'path': '', 07:06:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:00 INFO - Running post-action listener: _resource_record_post_action 07:06:00 INFO - ##### 07:06:00 INFO - ##### Running create-virtualenv step. 07:06:00 INFO - ##### 07:06:00 INFO - Running pre-action listener: _resource_record_pre_action 07:06:00 INFO - Running main action method: create_virtualenv 07:06:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:06:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:06:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:06:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:01 INFO - Using real prefix '/usr' 07:06:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:06:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:03 INFO - Installing pip.................done. 07:06:03 INFO - Return code: 0 07:06:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:03 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:03 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 07:06:03 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 07:06:03 INFO - Using env: {'DISPLAY': ':0', 07:06:03 INFO - 'HOME': '/home/cltbld', 07:06:03 INFO - 'LANG': 'en_US.UTF-8', 07:06:03 INFO - 'LANGUAGE': 'en_US:en', 07:06:03 INFO - 'LOGNAME': 'cltbld', 07:06:03 INFO - 'MAIL': '/var/mail/cltbld', 07:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:03 INFO - 'MOZ_NO_REMOTE': '1', 07:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:03 INFO - 'NO_EM_RESTART': '1', 07:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:03 INFO - 'SHELL': '/bin/bash', 07:06:03 INFO - 'SHLVL': '1', 07:06:03 INFO - 'TERM': 'linux', 07:06:03 INFO - 'TMOUT': '86400', 07:06:03 INFO - 'USER': 'cltbld', 07:06:03 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:03 INFO - '_': '/tools/buildbot/bin/python'} 07:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:06:03 INFO - Cleaning up... 07:06:03 INFO - Return code: 0 07:06:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:03 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:03 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 07:06:03 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 07:06:03 INFO - Using env: {'DISPLAY': ':0', 07:06:03 INFO - 'HOME': '/home/cltbld', 07:06:03 INFO - 'LANG': 'en_US.UTF-8', 07:06:03 INFO - 'LANGUAGE': 'en_US:en', 07:06:03 INFO - 'LOGNAME': 'cltbld', 07:06:03 INFO - 'MAIL': '/var/mail/cltbld', 07:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:03 INFO - 'MOZ_NO_REMOTE': '1', 07:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:03 INFO - 'NO_EM_RESTART': '1', 07:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:03 INFO - 'SHELL': '/bin/bash', 07:06:03 INFO - 'SHLVL': '1', 07:06:03 INFO - 'TERM': 'linux', 07:06:03 INFO - 'TMOUT': '86400', 07:06:03 INFO - 'USER': 'cltbld', 07:06:03 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:03 INFO - '_': '/tools/buildbot/bin/python'} 07:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:04 INFO - Downloading/unpacking psutil>=0.7.1 07:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:06:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:06:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:05 INFO - Installing collected packages: psutil 07:06:05 INFO - Running setup.py install for psutil 07:06:06 INFO - building 'psutil._psutil_linux' extension 07:06:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:06:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:06:06 INFO - building 'psutil._psutil_posix' extension 07:06:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:06:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:06 INFO - Successfully installed psutil 07:06:06 INFO - Cleaning up... 07:06:06 INFO - Return code: 0 07:06:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:06 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:06 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 07:06:06 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 07:06:06 INFO - Using env: {'DISPLAY': ':0', 07:06:06 INFO - 'HOME': '/home/cltbld', 07:06:06 INFO - 'LANG': 'en_US.UTF-8', 07:06:06 INFO - 'LANGUAGE': 'en_US:en', 07:06:06 INFO - 'LOGNAME': 'cltbld', 07:06:06 INFO - 'MAIL': '/var/mail/cltbld', 07:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:06 INFO - 'MOZ_NO_REMOTE': '1', 07:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:06 INFO - 'NO_EM_RESTART': '1', 07:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:06 INFO - 'SHELL': '/bin/bash', 07:06:06 INFO - 'SHLVL': '1', 07:06:06 INFO - 'TERM': 'linux', 07:06:06 INFO - 'TMOUT': '86400', 07:06:06 INFO - 'USER': 'cltbld', 07:06:06 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:06 INFO - '_': '/tools/buildbot/bin/python'} 07:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:06:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:06:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:06:08 INFO - Installing collected packages: mozsystemmonitor 07:06:08 INFO - Running setup.py install for mozsystemmonitor 07:06:08 INFO - Successfully installed mozsystemmonitor 07:06:08 INFO - Cleaning up... 07:06:08 INFO - Return code: 0 07:06:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:06:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:08 INFO - Using env: {'DISPLAY': ':0', 07:06:08 INFO - 'HOME': '/home/cltbld', 07:06:08 INFO - 'LANG': 'en_US.UTF-8', 07:06:08 INFO - 'LANGUAGE': 'en_US:en', 07:06:08 INFO - 'LOGNAME': 'cltbld', 07:06:08 INFO - 'MAIL': '/var/mail/cltbld', 07:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:08 INFO - 'MOZ_NO_REMOTE': '1', 07:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:08 INFO - 'NO_EM_RESTART': '1', 07:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:08 INFO - 'SHELL': '/bin/bash', 07:06:08 INFO - 'SHLVL': '1', 07:06:08 INFO - 'TERM': 'linux', 07:06:08 INFO - 'TMOUT': '86400', 07:06:08 INFO - 'USER': 'cltbld', 07:06:08 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:08 INFO - '_': '/tools/buildbot/bin/python'} 07:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:08 INFO - Downloading/unpacking blobuploader==1.2.4 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:10 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:06:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:06:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:06:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:11 INFO - Downloading docopt-0.6.1.tar.gz 07:06:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:06:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:11 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:11 INFO - Running setup.py install for blobuploader 07:06:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:06:11 INFO - Running setup.py install for requests 07:06:11 INFO - Running setup.py install for docopt 07:06:11 INFO - Successfully installed blobuploader requests docopt 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:11 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:11 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 07:06:11 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 07:06:11 INFO - Using env: {'DISPLAY': ':0', 07:06:11 INFO - 'HOME': '/home/cltbld', 07:06:11 INFO - 'LANG': 'en_US.UTF-8', 07:06:11 INFO - 'LANGUAGE': 'en_US:en', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MAIL': '/var/mail/cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SHLVL': '1', 07:06:11 INFO - 'TERM': 'linux', 07:06:11 INFO - 'TMOUT': '86400', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - '_': '/tools/buildbot/bin/python'} 07:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:12 INFO - Running setup.py (path:/tmp/pip-7nk3BH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:12 INFO - Running setup.py (path:/tmp/pip-NA5OeE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:12 INFO - Running setup.py (path:/tmp/pip-yrx4Zp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:12 INFO - Running setup.py (path:/tmp/pip-EJIDIw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:12 INFO - Running setup.py (path:/tmp/pip-3X5_Ve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:12 INFO - Running setup.py (path:/tmp/pip-VCQvuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:12 INFO - Running setup.py (path:/tmp/pip-eLxcS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:12 INFO - Running setup.py (path:/tmp/pip-IY3SYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:12 INFO - Running setup.py (path:/tmp/pip-2ARr9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:12 INFO - Running setup.py (path:/tmp/pip-ffLrMs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:12 INFO - Running setup.py (path:/tmp/pip-mlQdFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:12 INFO - Running setup.py (path:/tmp/pip-kDjhpd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:12 INFO - Running setup.py (path:/tmp/pip-KdXGq_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:12 INFO - Running setup.py (path:/tmp/pip-XAgoUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:13 INFO - Running setup.py (path:/tmp/pip-HazQ5T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:13 INFO - Running setup.py (path:/tmp/pip-caKTcb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:13 INFO - Running setup.py (path:/tmp/pip-29F9_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:13 INFO - Running setup.py install for manifestparser 07:06:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:06:13 INFO - Running setup.py install for mozcrash 07:06:13 INFO - Running setup.py install for mozdebug 07:06:13 INFO - Running setup.py install for mozdevice 07:06:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:06:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:06:13 INFO - Running setup.py install for mozfile 07:06:13 INFO - Running setup.py install for mozhttpd 07:06:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:06:13 INFO - Running setup.py install for mozinfo 07:06:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:06:13 INFO - Running setup.py install for mozInstall 07:06:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Running setup.py install for mozleak 07:06:14 INFO - Running setup.py install for mozlog 07:06:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Running setup.py install for moznetwork 07:06:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Running setup.py install for mozprocess 07:06:14 INFO - Running setup.py install for mozprofile 07:06:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Running setup.py install for mozrunner 07:06:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:06:14 INFO - Running setup.py install for mozscreenshot 07:06:14 INFO - Running setup.py install for moztest 07:06:14 INFO - Running setup.py install for mozversion 07:06:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:15 INFO - Cleaning up... 07:06:15 INFO - Return code: 0 07:06:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07: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')]} 07:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:15 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 07:06:15 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 07:06:15 INFO - Using env: {'DISPLAY': ':0', 07:06:15 INFO - 'HOME': '/home/cltbld', 07:06:15 INFO - 'LANG': 'en_US.UTF-8', 07:06:15 INFO - 'LANGUAGE': 'en_US:en', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MAIL': '/var/mail/cltbld', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SHLVL': '1', 07:06:15 INFO - 'TERM': 'linux', 07:06:15 INFO - 'TMOUT': '86400', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - '_': '/tools/buildbot/bin/python'} 07:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:15 INFO - Running setup.py (path:/tmp/pip-H2Ho0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:15 INFO - Running setup.py (path:/tmp/pip-0zr6Lw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:15 INFO - Running setup.py (path:/tmp/pip-OK5lT5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:15 INFO - Running setup.py (path:/tmp/pip-03vn_K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:15 INFO - Running setup.py (path:/tmp/pip-6Bd6zA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:15 INFO - Running setup.py (path:/tmp/pip-CmLbdJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:15 INFO - Running setup.py (path:/tmp/pip-oRWY8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:15 INFO - Running setup.py (path:/tmp/pip-t7it1w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:15 INFO - Running setup.py (path:/tmp/pip-YLifxP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:15 INFO - Running setup.py (path:/tmp/pip-Ss7SP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:15 INFO - Running setup.py (path:/tmp/pip-oBK4AX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:16 INFO - Running setup.py (path:/tmp/pip-n7H_Zf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:16 INFO - Running setup.py (path:/tmp/pip-P0pFF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:16 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)) 07:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:16 INFO - Running setup.py (path:/tmp/pip-AmBS5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:16 INFO - Running setup.py (path:/tmp/pip-HH8kg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:16 INFO - Running setup.py (path:/tmp/pip-YCXNmP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:16 INFO - Running setup.py (path:/tmp/pip-eqLlUB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:18 INFO - Downloading blessings-1.5.1.tar.gz 07:06:18 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 07:06:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:18 INFO - Installing collected packages: blessings 07:06:18 INFO - Running setup.py install for blessings 07:06:18 INFO - Successfully installed blessings 07:06:18 INFO - Cleaning up... 07:06:18 INFO - Return code: 0 07:06:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:06:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:06:18 INFO - Reading from file tmpfile_stdout 07:06:18 INFO - Current package versions: 07:06:18 INFO - argparse == 1.2.1 07:06:18 INFO - blessings == 1.5.1 07:06:18 INFO - blobuploader == 1.2.4 07:06:18 INFO - docopt == 0.6.1 07:06:18 INFO - manifestparser == 1.1 07:06:18 INFO - mozInstall == 1.12 07:06:18 INFO - mozcrash == 0.16 07:06:18 INFO - mozdebug == 0.1 07:06:18 INFO - mozdevice == 0.47 07:06:18 INFO - mozfile == 1.2 07:06:18 INFO - mozhttpd == 0.7 07:06:18 INFO - mozinfo == 0.9 07:06:18 INFO - mozleak == 0.1 07:06:18 INFO - mozlog == 3.1 07:06:18 INFO - moznetwork == 0.27 07:06:18 INFO - mozprocess == 0.22 07:06:18 INFO - mozprofile == 0.28 07:06:18 INFO - mozrunner == 6.11 07:06:18 INFO - mozscreenshot == 0.1 07:06:18 INFO - mozsystemmonitor == 0.0 07:06:18 INFO - moztest == 0.7 07:06:18 INFO - mozversion == 1.4 07:06:18 INFO - psutil == 3.1.1 07:06:18 INFO - requests == 1.2.3 07:06:18 INFO - wsgiref == 0.1.2 07:06:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:18 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:18 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 07:06:18 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 07:06:18 INFO - Using env: {'DISPLAY': ':0', 07:06:18 INFO - 'HOME': '/home/cltbld', 07:06:18 INFO - 'LANG': 'en_US.UTF-8', 07:06:18 INFO - 'LANGUAGE': 'en_US:en', 07:06:18 INFO - 'LOGNAME': 'cltbld', 07:06:18 INFO - 'MAIL': '/var/mail/cltbld', 07:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:18 INFO - 'MOZ_NO_REMOTE': '1', 07:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:18 INFO - 'NO_EM_RESTART': '1', 07:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:18 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:18 INFO - 'SHELL': '/bin/bash', 07:06:18 INFO - 'SHLVL': '1', 07:06:18 INFO - 'TERM': 'linux', 07:06:18 INFO - 'TMOUT': '86400', 07:06:18 INFO - 'USER': 'cltbld', 07:06:18 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:18 INFO - '_': '/tools/buildbot/bin/python'} 07:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 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)) 07:06:18 INFO - Cleaning up... 07:06:18 INFO - Return code: 0 07:06:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:18 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:18 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 07:06:18 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 07:06:18 INFO - Using env: {'DISPLAY': ':0', 07:06:18 INFO - 'HOME': '/home/cltbld', 07:06:18 INFO - 'LANG': 'en_US.UTF-8', 07:06:18 INFO - 'LANGUAGE': 'en_US:en', 07:06:18 INFO - 'LOGNAME': 'cltbld', 07:06:18 INFO - 'MAIL': '/var/mail/cltbld', 07:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:18 INFO - 'MOZ_NO_REMOTE': '1', 07:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:18 INFO - 'NO_EM_RESTART': '1', 07:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:18 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:18 INFO - 'SHELL': '/bin/bash', 07:06:18 INFO - 'SHLVL': '1', 07:06:18 INFO - 'TERM': 'linux', 07:06:18 INFO - 'TMOUT': '86400', 07:06:18 INFO - 'USER': 'cltbld', 07:06:18 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:18 INFO - '_': '/tools/buildbot/bin/python'} 07:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:19 INFO - Downloading/unpacking jsonschema 07:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:20 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 07:06:20 INFO - Downloading/unpacking functools32 (from jsonschema) 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:06:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:20 INFO - warning: no files found matching '*.txt' 07:06:20 INFO - no previously-included directories found matching 'build' 07:06:20 INFO - no previously-included directories found matching 'dist' 07:06:20 INFO - no previously-included directories found matching '.git*' 07:06:21 INFO - Installing collected packages: jsonschema, functools32 07:06:21 INFO - Running setup.py install for functools32 07:06:21 INFO - warning: no files found matching '*.txt' 07:06:21 INFO - no previously-included directories found matching 'build' 07:06:21 INFO - no previously-included directories found matching 'dist' 07:06:21 INFO - no previously-included directories found matching '.git*' 07:06:21 INFO - Successfully installed jsonschema functools32 07:06:21 INFO - Cleaning up... 07:06:21 INFO - Return code: 0 07:06:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:21 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 0x7f3fd070bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dae630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:21 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 07:06:21 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 07:06:21 INFO - Using env: {'DISPLAY': ':0', 07:06:21 INFO - 'HOME': '/home/cltbld', 07:06:21 INFO - 'LANG': 'en_US.UTF-8', 07:06:21 INFO - 'LANGUAGE': 'en_US:en', 07:06:21 INFO - 'LOGNAME': 'cltbld', 07:06:21 INFO - 'MAIL': '/var/mail/cltbld', 07:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:21 INFO - 'MOZ_NO_REMOTE': '1', 07:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:21 INFO - 'NO_EM_RESTART': '1', 07:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:21 INFO - 'SHELL': '/bin/bash', 07:06:21 INFO - 'SHLVL': '1', 07:06:21 INFO - 'TERM': 'linux', 07:06:21 INFO - 'TMOUT': '86400', 07:06:21 INFO - 'USER': 'cltbld', 07:06:21 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:21 INFO - '_': '/tools/buildbot/bin/python'} 07:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:21 INFO - Downloading/unpacking flake8 07:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:06:23 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 07:06:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:06:23 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 07:06:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:23 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 07:06:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:06:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:23 INFO - no previously-included directories found matching 'docs/_build' 07:06:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:06:23 INFO - Running setup.py install for pep8 07:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:23 INFO - no previously-included directories found matching 'docs/_build' 07:06:23 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:06:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:06:23 INFO - Cleaning up... 07:06:24 INFO - Return code: 0 07:06:24 INFO - Running post-action listener: _resource_record_post_action 07:06:24 INFO - Running post-action listener: _start_resource_monitoring 07:06:24 INFO - Starting resource monitoring. 07:06:24 INFO - ##### 07:06:24 INFO - ##### Running install step. 07:06:24 INFO - ##### 07:06:24 INFO - Running pre-action listener: _resource_record_pre_action 07:06:24 INFO - Running main action method: install 07:06:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:06:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:06:24 INFO - Reading from file tmpfile_stdout 07:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:06:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:06:24 INFO - Reading from file tmpfile_stdout 07:06:24 INFO - Output received: 07:06:24 INFO - Usage: mozinstall [options] installer 07:06:24 INFO - Options: 07:06:24 INFO - -h, --help show this help message and exit 07:06:24 INFO - -d DEST, --destination=DEST 07:06:24 INFO - Directory to install application into. [default: 07:06:24 INFO - "/builds/slave/test-pgo"] 07:06:24 INFO - --app=APP Application being installed. [default: firefox] 07:06:24 INFO - mkdir: /builds/slave/test-pgo/build/application 07:06:24 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'] 07:06:24 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 07:06:40 INFO - Reading from file tmpfile_stdout 07:06:40 INFO - Output received: 07:06:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:06:40 INFO - Running post-action listener: _resource_record_post_action 07:06:40 INFO - ##### 07:06:40 INFO - ##### Running run-tests step. 07:06:40 INFO - ##### 07:06:40 INFO - Running pre-action listener: _resource_record_pre_action 07:06:40 INFO - Running main action method: run_tests 07:06:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:06:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:06:40 INFO - Python 2.7.3 07:06:40 INFO - Return code: 0 07:06:40 INFO - grabbing minidump binary from tooltool 07:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:40 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 0x1e3f840>, '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 0x1dac6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dacb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:06:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:06:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:06:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:40 INFO - Return code: 0 07:06:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:06:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:06:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:06:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:06:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:06:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:06:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:06:41 INFO - Return code: 0 07:06:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 07:06:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 07:06:41 INFO - Using env: {'DISPLAY': ':0', 07:06:41 INFO - 'HOME': '/home/cltbld', 07:06:41 INFO - 'LANG': 'en_US.UTF-8', 07:06:41 INFO - 'LANGUAGE': 'en_US:en', 07:06:41 INFO - 'LOGNAME': 'cltbld', 07:06:41 INFO - 'MAIL': '/var/mail/cltbld', 07:06:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:06:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:41 INFO - 'MOZ_NO_REMOTE': '1', 07:06:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:41 INFO - 'NO_EM_RESTART': '1', 07:06:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:06:41 INFO - 'SHELL': '/bin/bash', 07:06:41 INFO - 'SHLVL': '1', 07:06:41 INFO - 'TERM': 'linux', 07:06:41 INFO - 'TMOUT': '86400', 07:06:41 INFO - 'USER': 'cltbld', 07:06:41 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196', 07:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:41 INFO - '_': '/tools/buildbot/bin/python'} 07:06:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 07:06:41 INFO - mozversion application_buildid: 20151230043003 07:06:41 INFO - mozversion application_changeset: c690c50b2b543b420803e8192d6e08e06b20e0a3 07:06:41 INFO - mozversion application_display_name: Nightly 07:06:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:41 INFO - mozversion application_name: Firefox 07:06:41 INFO - mozversion application_remotingname: firefox 07:06:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:06:41 INFO - mozversion application_vendor: Mozilla 07:06:41 INFO - mozversion application_version: 46.0a1 07:06:41 INFO - mozversion platform_buildid: 20151230043003 07:06:41 INFO - mozversion platform_changeset: c690c50b2b543b420803e8192d6e08e06b20e0a3 07:06:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:06:41 INFO - mozversion platform_version: 46.0a1 07:06:41 INFO - using testdate: 1451488001 07:06:41 INFO - actual date: 1451488001 07:06:41 INFO - starting webserver on 'localhost:33745' 07:06:41 INFO - SUITE-START | Running 3 tests 07:06:41 INFO - TEST-START | dromaeo_css 07:06:41 INFO - operating with platform_type : linux_ 07:06:41 INFO - Initialising browser for dromaeo_css test... 07:06:41 INFO - TEST-INFO | started process 10943 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPwxu1G/profile http://localhost:33745/getInfo.html) 07:06:48 INFO - PROCESS | 10943 | __metrics Screen width/height:1600/1200 07:06:48 INFO - PROCESS | 10943 | colorDepth:24 07:06:48 INFO - PROCESS | 10943 | Browser inner width/height: 1024/697 07:06:48 INFO - PROCESS | 10943 | __metrics 07:06:48 INFO - PROCESS | 10943 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:06:48 INFO - PROCESS | 10943 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 07:06:49 INFO - TEST-INFO | 10943: exit 0 07:06:49 INFO - Browser initialized. 07:06:49 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:49 INFO - TEST-INFO | started process 11077 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPwxu1G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:00 INFO - PROCESS | 11077 | RSS: Main: 150388736 07:07:00 INFO - PROCESS | 11077 | 07:07:50 INFO - PROCESS | 11077 | 1451488070559 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:09:59 INFO - PROCESS | 11077 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33745/tests/dromaeo/cssquery-ext.html) 07:10:00 INFO - PROCESS | 11077 | RSS: Main: 159281152 07:10:00 INFO - PROCESS | 11077 | 07:13:02 INFO - PROCESS | 11077 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-ext.html (next: http://localhost:33745/tests/dromaeo/cssquery-jquery.html) 07:13:03 INFO - PROCESS | 11077 | RSS: Main: 155820032 07:13:03 INFO - PROCESS | 11077 | 07:16:05 INFO - PROCESS | 11077 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33745/tests/dromaeo/cssquery-mootools.html) 07:16:05 INFO - PROCESS | 11077 | RSS: Main: 153853952 07:16:05 INFO - PROCESS | 11077 | 07:19:07 INFO - PROCESS | 11077 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33745/tests/dromaeo/cssquery-prototype.html) 07:19:07 INFO - PROCESS | 11077 | RSS: Main: 151826432 07:19:07 INFO - PROCESS | 11077 | 07:22:10 INFO - PROCESS | 11077 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33745/tests/dromaeo/cssquery-yui.html) 07:22:10 INFO - PROCESS | 11077 | RSS: Main: 152879104 07:22:10 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-yui.html (next: http://localhost:33745/tests/dromaeo/cssquery-dojo.html) 07:25:13 INFO - PROCESS | 11077 | RSS: Main: 155435008 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | __start_tp_report 07:25:13 INFO - PROCESS | 11077 | _x_x_mozilla_page_load 07:25:13 INFO - PROCESS | 11077 | _x_x_mozilla_page_load_details 07:25:13 INFO - PROCESS | 11077 | |i|pagename|runs| 07:25:13 INFO - PROCESS | 11077 | |0;dojo.html;3176.9999999999995;3236.0130160301114;3246.594175728034;3278.70491655751;3287.1124796304985;5263.552598029172;5332.3068001159845;5359.651622644526;5362.8123015694455;5381.300430943977;5320.308359913206;5350.063738845696;5414.43148469411;5464.508194262516;5473.233747275374;4644.233701439275;4920.655554111214;5031.496850314976;5033.219850923113;5054.646174767768;4806.279058141272;4964.87587810304;4995.125852975733;5028.245763135523;5052.79788808449;4849.5877850382585;4901.509849015106;4907.1657818171;4939.8024079036795;4949.727764972925;4881.999190166008;4894.632902532324;4902.044101400228;4915.926261106087;4931.926021109686;4849.466558678542;4896.975515122402;4919.7540122993705;4921.704697718148;4921.852344429637;5129.9743501282255;5185.507376799235;5204.9479505204845;5271.341082364705;5289.206619007141;5842.795502157446;5851.683371241479;5854.326752423441;5870.11948207768;5873.44202300785;5862.794802181946;5878.911816322759;5883.941160588382;5887.5584331174905;5896.557758168155;5428.809991650312;5439.0209762242785;5440.211169380457;5487.972560137214;5541.6120871539415;5817.476427121579;5877.5591830612875;5917.615355001911;5921.28944526651;5930.762769489258;5701.059325211377;5724.542036637059;5732.541396688255;5745.482906538348;5800.59395842287;5714.9714251429305;5789.971050144806;5801.216835727123;5886.440788125121;5893;5785.566082543826;5822.243108395882;5822.272215973004;5822.563307751935;5828.912566311508;5799.565032622486;5808.128780682931;5809.6223745457255;5814.156947242626;5835.503982161479;4390.517043125254;4415.933760993587;4460.620847227957;4472.485664148599;4513.909721805546;3969.7221194516105;3980.8009599520487;3990.1421194443333;4002.4996875390575;4027.033511957109;5315.548178404802;5379.919301210407;5382.542483888835;5394.460553944574;5423.945760542423;5698.401667824902;5736.483716465455;5758.654480731169;5786.450287222707;5811.27359080115;5322.680639161663;5360.892782144335;5363.383210930715;5375.919361209585;5379.488948549882;4846.5638092571135;4957.529034741766;4974.452810190876;4994.126027945095;5000.724960127228;5811.476967072984;5931.228940237742;5969.253843269678;5987.820365389045;6031;5761.798337058183;5784.768609255582;5803.303603567599;5814.360420353673;5829.59192856496;5776.537876969916;5874.353821079592;5881.147233651182;5885.087811389241;5899.439553242435;5744.396838331915;5824.126381042708;5829.300483941955;5832.096025116114;5887.1757953885635;5933.495652869382;5933.970330148321;5974.910376344272;5985.521158307238;6010.669413182142;5555.916661250165;5622.044252477007;5643.548516118783;5765.135229715576;5774.8845023098465;5726.885462290647;5739.655620662774;5750.482456578928;5775.624584402;5823.563232757476;5595.300587426572;5636.633618814764;5654.7455364509515;5658.122990936411;5670.971645141748;5639.915401269066;5758.856028599319;5763.538916886723;5766.077427611562;5769.74036168365;5560.388357280777;5620.297462817148;5633.915491267552;5649.54803615718;5659.6887171204335 07:25:13 INFO - PROCESS | 11077 | |1;ext.html;519.3741541442562;525.4902744337993;541.9214213938978;551.8493940134819;565.2087078090675;36147.4577881332;37187;37314.440283395736;37429.81285093578;37431.25137497248;40784.79607601958;41108.58891411085;41238;41270;41560;8533.232009119178;8670.263027642657;8706.608202630865;8708.695195668153;8737.694180703676;8383.413161078726;8429.536375499376;8445.831083378329;8446.324294056492;8517.72234164877;8711;8785.604647790833;8844.646214151426;8847;8851.911480885205;8706;8715.782105447352;8750.518721470316;8801.251893589053;8836.779080522974;8614.52620105894;8702.477851328877;8738.73783786481;8739.257163141141;8743.956280218621;39337.803310983545;39479.80260098681;39690.007749806195;39728.40407393892;39800.60199397998;3354.781939173946;3444.621091679913;3525.435930251173;3983.1237127831832;3998.5001874765653;29904.55143172854;30156.849215754;30183.547246791317;30228;30327.090187294416;3833.691429025115;3914.2954268231706;3967.761934283952;3995.720299579031;4043.353063509824;258263;259823;260234.69882650467;260374;263107.9999999981;53313.73343133259;53901;57558.424415755304;57966;60950.39049609536;55990.44009559934;56366;56460;56664;56672.43327566754;15294.694106118039;15433.614159646098;15447.613809654624;15526.456574019856;15551.766723499157;11722.120840936965;11726.70683232909;11818.054555635528;11829.881701182878;11855;19553.315633952745;19855.503612409517;20385.18459261613;20506.794932050787;20535.075921583564;7605.277498637621;7678.5392876427595;7726.6092103421925;7759.146493885668;7872.645730942121;925.8009527951388;1015.5176291261739;1049.7690508088208;1057.751428414322;1126.1722633864103;25430.618540721905;25557.74442255591;25754;25930.740692592834;26008.829602667924;1031.8813336466403;1059.560282482761;1098.9505472253768;1137.590467431724;1143.5540139345662;13713.520026799015;13800.861991379958;13819.447222111003;14005.929970350084;14089.859101408854;264692;267375;269832;269935;270600;51698.22452663213;52806.471935280926;52825.207621885704;52904;52926;1319.6436962020393;1327.044527939901;1329.8537160912292;1335.2989680417859;1338.1034706746502;25567.232983009795;26840.328991774582;26861.597076044265;27212;27285.727142729113;45029.09941801211;45221;45364.77317613391;45451.545484546055;45703.77148114238;309888;310065;311839;312583;312991;31727.524087139172;31807.204819879687;32553.34893302168;32603.184920376232;32901.50647740238;38101.809490952364;38923.2215355697;39062.2187556253;39070.21859562736;40053.599464006154;33664.49503257404;35964.10089747777;36553;37806.24387512289;37911.62088379081;31990.36019279555;32953.67046329602;33069.17327066843;33372.33255334928;33588.1602959928;32676.83661581677;32830;33102.172445688084;33153.668463316026;33255.833720831244;29043.85478072596;29364.706352937053;30421.543676844423;31090.22274443157;31121.533177002817;22970.770292296864;24507.38731531726;24698.876505617358;24744.752552474965;24915.626265606392 07:25:13 INFO - PROCESS | 11077 | |2;jquery.html;357.1143563961374;357.5661596996045;357.99999999999994;360.81057444841474;363.5891442669783;16917.83082169178;17370;17747.82252177478;17998.82001179988;18284.634307313845;16197.676046479093;16341.428050018252;16441.506754797345;16486.917565412157;16930;4906.681065730725;4991.825286114987;5016.423111342206;5033.697978121306;5038.823641172559;4377.47470303564;5005.6496045276845;5021.9748901255625;5050.949490505103;5052.393712754475;5023.949760502384;5167.638265321429;5182.274481572583;5406.783728650869;5449.618526703132;5049.520295571896;5066.949330506684;5101.030804147237;5104.6937183768905;6179.104029915637;6009.038553831366;6103.176071230371;6114.633122012693;6117.480014198798;6146.35463276354;21038.894805526026;21301;21527.246546370803;22399.216027439124;22489.32532024042;2181.4328274648547;2181.530970841277;2201;2253.3803204118835;2306.976930230693;13875;13932.164070155823;14108.87129029675;14306.28468576567;14396.712065758731;1869.2896699254197;1876.7278744581959;1933.3523269704526;1947.1627200303863;1985.4639247403265;59598.68045737556;63990.68004659947;65163.67418162926;65340.36649083763;66094.3390566093;15634.609134771721;15660.608484787743;15763.605909852346;15860.60348491297;15923.761143582855;24271;24294.635580466307;24408.389790255387;24465.38836529101;24627;9148.222401095982;9173.541322933826;9229.16937475617;9253;9255.305852061123;7848.215178482106;7882.5270483771155;7895.486793358414;7903.130655627876;7909.406794490436;7899.249571290718;7932.286094251545;7934.642941067666;7953.562554059582;7991.440599158003;1797.4607617714632;2953.42408230393;3003.7296643302207;3066.5860108885013;3083.7070478304527;835.7492752174323;893.9284857211537;937.475013992153;979.3487330924855;1013.9898601014042;16497.91751041237;16801.495955121365;16957.236924338187;16981.915090424467;16995.74506382405;916.5600511754395;924.3113880159324;956.3449037409397;967.777411195429;969.2585172343163;9634.421934683942;9757.609695612096;9775.364601300893;9831.901680983241;9870.457124858201;494914;496513;571544;611771;617146;76662;77153;77389;78544.21455785484;78696;1077.06833588945;1079.0666073846223;1080.5677728908342;1087.690008347617;1090.1006669497538;14807.33366998466;14896.776548351567;14971.850281497045;15250.847491524943;15521.76717349218;32250.677493224768;32463;33335.33329333448;34328.65671343354;35088;39981.40027899642;40226.39660405038;42909.141817164105;43580.782096089315;43818;9759.56081976327;9777.315587908779;9779.608815647294;9869.901300987185;10022.3485473444;11832.940835295769;11933.343666098448;12016.939915300367;12036.819447708116;15515.767263491283;11566.363849987994;12196.512139514674;14108.858911410754;14180.936429767602;14494.492692755703;13097.672558186121;13868.237246951514;13890.722185556031;14126.43494260218;14228.644283892572;14109.788353174916;14204.715905682035;14247.145171289756;14645.92677036608;14676.41294348214;9396.67111651089;9521.333506654744;9530.903946046294;9559.569819358285;9591.040895910353;12413;14090.929545352208;14334.139951602938;14648.780268295772;14975.251237438302 07:25:13 INFO - PROCESS | 11077 | |3;mootools.html;1398.951036713715;1450.514077783942;1537.6002239417749;1708.2483707168853;1709.3077303692;7020.438364930806;7043.612601306926;7159.749408770694;7273.818154546132;7314.232005639411;7258.745943891965;7269.74555890544;7312.451566132535;7319.2680731926785;7361.374283185923;2179.3897708641607;2215.401841502793;2215.4350640586626;2217.944551386212;2221.255879280443;2193.7148170737782;2216.279709094543;2237.7538470768204;2241.6413373860187;2248.853824501402;2189.5073608438133;2190.463336482556;2199.6260635691892;2231.1967691631;2244.6408574628063;2203.22886989554;2227.40973641985;2242.798148166673;2257.4356410897194;2258.4692597239637;2190.605690975624;2215.1139544182297;2215.9556808863895;2216.5899308627954;2216.8891555422165;7094.609796461193;7169.24722904098;7171.89242161368;7192.2807719228185;7205.243449437786;4503.144402563503;4551.704139230973;4556.589906908394;4564.292534657134;4584.931226031579;2819.8167119137397;2924.824510529375;2927.3413481966386;2941.485240082977;2964.125582953034;921.4747593871496;926.8795056642593;933.3280038372361;946.5787724462617;969.8254314223437;9829.655962041366;9855.162311203556;9860.704178874645;9892.071046146004;9909.40543567381;3960.4257382679352;4009.218202450494;4043.4137050127565;4047.0894048838777;4056.6551843093666;8071.071826739882;8073.354131669453;8084.029916410069;8089.555074470961;8095.5142691438705;4495.910081798411;4504.346869703874;4512.2329204035395;4529.297958816389;4535.047639995571;4129.380592911088;4163.479565054368;4209.200251952119;4210.7473551587;4214.978925105354;3338.499225116252;3367.5958884933966;3384.9153771155425;3394.0496660934978;3398.150462384404;1084.6745976207105;1093.4532733633184;1093.5680406239492;1101.3061771084326;1101.3281898042187;1052.8631277933819;1069.417167643636;1072.8980746829038;1195.808670612715;1318.0905175428923;6667.933320666732;6698.196216453959;6752.054712340277;6763.289854565298;6772.255051944282;1039.9168066554657;1043.3844032020993;1051.4164638625484;1057.4289883462998;1066.7973085113958;5557.166425036196;5590.468905453975;5597.972010139923;5603.971980140154;5615.6630602164005;8449;8536.530490822941;8730.388872778845;8777.780555486164;8806.779830504289;8697.434666746642;8704.95647521771;8715.869261961076;8725;8752.387332886638;6890.552114112566;6922.100126983561;7027.613481258478;7035.50751447404;7065.258147894499;6664.266930637723;6694.933050669431;6708.127943367331;6712.9664351679885;6774.254831968578;7589.43079269046;7719.382449404146;7851.489653172754;7860.528368297921;7903.723369682033;7998.360131189607;8012.639431225725;8054.718084867001;8088.312493438124;8236.917630823615;6182.938170618237;6234.875302494015;6235.407636274546;6236.875262494634;6242.344553821783;6735.5621884579305;6950.756723514653;6976.093107896144;6997.090378250999;7008.264132266038;6434.099226108442;6495.1556297681;6586.37429444202;6637.966810165918;6664.266930637529;6387.329330420239;6429.871402571829;6442.516811239082;6499.902501462388;6521.9673901630185;6460.12788273577;6479.902801458076;6522.086907832812;6524.380183882524;6526.804195873941;5952.553558483044;5968;5975.671338076448;5977.133315669291;5989.64062156272;6027.60820546663;6119.2350956130485;6125.264968203844;6138.202033735586;6155.692215389123 07:25:13 INFO - PROCESS | 11077 | |4;prototype.html;333.3815771743416;334.1245935648601;338.83058470764627;345.71305816172577;349.8495646871844;6293.307736149026;6295.213098362705;6311.400416960393;6352.714127864246;6488;6300.275468321144;6335.904961425582;6348.761991411677;6357.68211589421;6360.459360954313;4812.23004319309;4813.446453657822;4816.855494335158;4817.132916075105;4826;4800.279958006292;4811.9654274331015;4820.421549414075;4831.396075490564;4833.637477189207;4659.068186362724;4687.179743544883;4714.387129673138;4715.669903106784;4720.386349774524;4697.953020469786;4702.27114797207;4718.339432479422;4719.056188762262;4724.7401392923375;4027.939580906289;4041.3937909313545;4054.7972601370107;4060.228556574271;4074.3684728867074;5973.761049558012;5999.370066143036;6010.158577799111;6038.426349496791;6044.546659000593;5369.6509726867625;5561.833145005616;5572.136318870582;5588.30146231721;5600.4959553639965;6725.361090696425;6733.8653226935185;6738.966305168492;6751.189857217166;6756.121704178426;4595.931061034087;4597.195490789099;4602;4614.676972611918;4616.676832621718;6734.93265067348;6934.341237582422;6983.266756990493;6987.44100471956;6989.370956613879;4686.320483529869;4717.646176536773;4722.787474563653;4728.810847566059;4739.644526660514;4764.118638051971;4771.73755443454;4782.784774685148;4791.736454494967;4797.832075877328;5542.944570554324;5547.972260138674;5551.666899986014;5564.998300305984;5569;6490.415862572391;6609.933900661028;6661.500387470959;6665.366790154928;6665.566738162004;1633.4936169787404;1657.4778944632403;1659.8008239011153;1662.069241224918;1665.1091665958654;1097.8956999085074;1117.1230583991528;1117.80997230471;1128.949197286124;1134.914881383883;6274.874502509924;6275.341089185661;6287.905681414691;6300.479808076806;6307.558470906993;6807.353301436356;6818.386345228953;6848.589084654936;6854.485913556404;6879.931200688029;6124.173236613089;6238.781642642486;6271.216097987752;6278.183836101278;6284.874302514016;3728.7203459740085;3739.5512538495555;3740.6259374062374;3743.887683369503;3749.512563366745;6936.965315173392;6992.16094068715;6995.930040699528;6996.300369962963;7006.649667516604;7027.8243043923285;7049.718011279594;7058.223595404502;7072.9646351767915;7077.363037326665;7173.92826071743;7198.388137008308;7202.4238060954995;7204.92795072053;7216.603086830275;7039.1553013638695;7057.964710176417;7062.329078737512;7078.8938165928585;7087.14954205478;6823.215330236888;6999.055127557918;7012.894806578008;7022.052022977037;7031.613261270679;7195.676194571152;7195.748148814766;7213.314735100157;7214.314640109181;7214.74748383825;4636.884077898079;4640.1879671058105;4644.164050470948;4647.047355292225;4659.836905708284;6951.582905025714;7048.682809273698;7079.1858936223;7081.575105493687;7131.072960515307;6812.659367031728;6859.965700171467;6865.931340686529;6878.518503704692;6886.965565172142;6850.862982740417;6861.279565645735;6869.793906182823;6873.931260687529;6875.3812156906115;6546.705398256994;6630.270670226368;6714.563553369016;6727.428168605723;6741.393274605113;6835.58986460814;6870.175578930561;6887.483438742214;6890.586564806128;6891.3797758202;6591.901121483277;6684.799456016327;6695.732170713117;6696.4977626679165;6699.129113215251 07:25:13 INFO - PROCESS | 11077 | |5;yui.html;716.1763971432852;775.802170446536;788.4756636836504;824.6971970231411;839.6977088248232;13021.934890325547;13041.41313640886;13172.34138293084;13224.074314797968;13242.139260948032;11716.179867409284;12484.81272780909;12556.686082847911;12559.120861539695;12574.622761317152;800.4996876951919;834.1533343656193;845.3279642684081;845.8012367093728;846.8983721953374;821.6097353756948;829.1294141151797;829.8381815545971;829.9626516806728;830.2320353672859;875.5622188905547;880.5025160784169;881.0484676549344;881.22012019363;881.6737807011415;865.4158443050916;865.705660075571;866.4065115395911;869.0917990699702;871.0505548951642;641.6150309814121;643.1028714942676;643.2217017408941;645.554567348528;646.034178902539;12576.11967162299;12682.936585317015;12708.872911270953;12718;12719.491220351174;11874.406279686067;11953.103517236243;11976.92207701311;12102.971247443978;12169.634910952596;10130.797384052277;10391.740206494822;10561.894381056169;10566.260361774679;10639.255252132354;3600.4959305697225;3606.1525541497726;3645.981770091159;3656.1042544576485;3746.119661879456;48565.271520927214;48982;49052;49412;49450.25824612634;9448.763780905394;9489.38319009276;9872.45701486425;10073.194144468425;10169.796604068026;17699.292028318723;17721.822781772276;17739.201735921913;17740.55648608795;17844.643107137785;7573.2805383488485;7636.50362726421;7677.462577619624;7731.304182623591;7745.6127193640095;4121.835126594902;4334.349847522897;4357.673174511924;4392.582704643118;4406.008648054162;2968.302448924501;2987.3875855449583;2994.8802047918275;2999.5650630658433;3014.110837303001;514.7194778845538;515.4742162993725;529.9072662284085;531.2854211086083;535.0315928170024;542.8778524831881;561.581621691834;601.8164459839703;643.0547095769211;645.2515082504273;7838.059432867978;8051;8500.14998500145;8877.689280875138;8992.955035224782;512.6898226572944;598.6647477412663;623.0996210475819;626.743035355502;704.0354714041694;3972.7616343019513;4015.6748273069816;4053.3717273822604;4102.938455923164;4130.153318569686;57634.42365576374;61362;61373;61496.69251653802;61517.38482615117;51187.488125119016;51424.74287628538;51641.225381619304;52528.47471525312;52537.7373113132;46046.309305360446;46291.768541157755;46540.99999999932;46550.76724616355;47290.29064564034;7661.846763064819;7829.960850195713;7918.3665306776475;7960.124386317616;8009.8398032040195;33730.831345843115;34094.31811363808;34293.48559771555;34935.825320873235;35103.297934041686;40779.1844163121;40873.59126408698;43891;46211.76894115508;46707.53292467032;9522.23822094217;10002.299839011199;10078.193744500275;10370.377777333384;10396.584136634752;10799.784004319712;10935.781284374109;11016.559337626406;11143.609973650884;11717.472713728073;9860.852087218555;10011.649592264526;10355.94822025885;10888.18338624622;10924.12606991423;9971.900280997388;10006.749831253986;10080.64717734905;10142.391456512632;10176.236782241214;10004.435562244846;10396.532156053147;10421.218408619232;10504.894951050697;10536.473176341306;8568.485890846569;8597.82804343897;8730.476171429735;8854;9017.549122543714;7672.808179795326;7727.4204434668745;7893.210678932061;8142.226488483585;8288.544130072903 07:25:13 INFO - PROCESS | 11077 | __end_tp_report 07:25:13 INFO - PROCESS | 11077 | __start_cc_report 07:25:13 INFO - PROCESS | 11077 | _x_x_mozilla_cycle_collect,307 07:25:13 INFO - PROCESS | 11077 | __end_cc_report 07:25:13 INFO - PROCESS | 11077 | __startTimestamp1451489113755__endTimestamp 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | ------- Summary: start ------- 07:25:13 INFO - PROCESS | 11077 | Number of tests: 6 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | [#0] dojo.html Cycles:165 Average:5389.61 Median:5639.92 stddev:605.67 (10.7%) stddev-sans-first:582.12 07:25:13 INFO - PROCESS | 11077 | Values: 3177.0 3236.0 3246.6 3278.7 3287.1 5263.6 5332.3 5359.7 5362.8 5381.3 5320.3 5350.1 5414.4 5464.5 5473.2 4644.2 4920.7 5031.5 5033.2 5054.6 4806.3 4964.9 4995.1 5028.2 5052.8 4849.6 4901.5 4907.2 4939.8 4949.7 4882.0 4894.6 4902.0 4915.9 4931.9 4849.5 4897.0 4919.8 4921.7 4921.9 5130.0 5185.5 5204.9 5271.3 5289.2 5842.8 5851.7 5854.3 5870.1 5873.4 5862.8 5878.9 5883.9 5887.6 5896.6 5428.8 5439.0 5440.2 5488.0 5541.6 5817.5 5877.6 5917.6 5921.3 5930.8 5701.1 5724.5 5732.5 5745.5 5800.6 5715.0 5790.0 5801.2 5886.4 5893.0 5785.6 5822.2 5822.3 5822.6 5828.9 5799.6 5808.1 5809.6 5814.2 5835.5 4390.5 4415.9 4460.6 4472.5 4513.9 3969.7 3980.8 3990.1 4002.5 4027.0 5315.5 5379.9 5382.5 5394.5 5423.9 5698.4 5736.5 5758.7 5786.5 5811.3 5322.7 5360.9 5363.4 5375.9 5379.5 4846.6 4957.5 4974.5 4994.1 5000.7 5811.5 5931.2 5969.3 5987.8 6031.0 5761.8 5784.8 5803.3 5814.4 5829.6 5776.5 5874.4 5881.1 5885.1 5899.4 5744.4 5824.1 5829.3 5832.1 5887.2 5933.5 5934.0 5974.9 5985.5 6010.7 5555.9 5622.0 5643.5 5765.1 5774.9 5726.9 5739.7 5750.5 5775.6 5823.6 5595.3 5636.6 5654.7 5658.1 5671.0 5639.9 5758.9 5763.5 5766.1 5769.7 5560.4 5620.3 5633.9 5649.5 5659.7 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | [#1] ext.html Cycles:180 Average:44565.84 Median:18554.56 stddev:73346.79 (395.3%) stddev-sans-first:73477.99 07:25:13 INFO - PROCESS | 11077 | Values: 519.4 525.5 541.9 551.8 565.2 36147.5 37187.0 37314.4 37429.8 37431.3 40784.8 41108.6 41238.0 41270.0 41560.0 8533.2 8670.3 8706.6 8708.7 8737.7 8383.4 8429.5 8445.8 8446.3 8517.7 8711.0 8785.6 8844.6 8847.0 8851.9 8706.0 8715.8 8750.5 8801.3 8836.8 8614.5 8702.5 8738.7 8739.3 8744.0 39337.8 39479.8 39690.0 39728.4 39800.6 3354.8 3444.6 3525.4 3983.1 3998.5 29904.6 30156.8 30183.5 30228.0 30327.1 3833.7 3914.3 3967.8 3995.7 4043.4 258263.0 259823.0 260234.7 260374.0 263108.0 53313.7 53901.0 57558.4 57966.0 60950.4 55990.4 56366.0 56460.0 56664.0 56672.4 15294.7 15433.6 15447.6 15526.5 15551.8 11722.1 11726.7 11818.1 11829.9 11855.0 19553.3 19855.5 20385.2 20506.8 20535.1 7605.3 7678.5 7726.6 7759.1 7872.6 925.8 1015.5 1049.8 1057.8 1126.2 25430.6 25557.7 25754.0 25930.7 26008.8 1031.9 1059.6 1099.0 1137.6 1143.6 13713.5 13800.9 13819.4 14005.9 14089.9 264692.0 267375.0 269832.0 269935.0 270600.0 51698.2 52806.5 52825.2 52904.0 52926.0 1319.6 1327.0 1329.9 1335.3 1338.1 25567.2 26840.3 26861.6 27212.0 27285.7 45029.1 45221.0 45364.8 45451.5 45703.8 309888.0 310065.0 311839.0 312583.0 312991.0 31727.5 31807.2 32553.3 32603.2 32901.5 38101.8 38923.2 39062.2 39070.2 40053.6 33664.5 35964.1 36553.0 37806.2 37911.6 31990.4 32953.7 33069.2 33372.3 33588.2 32676.8 32830.0 33102.2 33153.7 33255.8 29043.9 29364.7 30421.5 31090.2 31121.5 22970.8 24507.4 24698.9 24744.8 24915.6 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | [#2] jquery.html Cycles:180 Average:29919.33 Median:34708.33 stddev:91491.98 (263.6%) stddev-sans-first:91721.71 07:25:13 INFO - PROCESS | 11077 | Values: 357.1 357.6 358.0 360.8 363.6 16917.8 17370.0 17747.8 17998.8 18284.6 16197.7 16341.4 16441.5 16486.9 16930.0 4906.7 4991.8 5016.4 5033.7 5038.8 4377.5 5005.6 5022.0 5050.9 5052.4 5023.9 5167.6 5182.3 5406.8 5449.6 5049.5 5066.9 5101.0 5104.7 6179.1 6009.0 6103.2 6114.6 6117.5 6146.4 21038.9 21301.0 21527.2 22399.2 22489.3 2181.4 2181.5 2201.0 2253.4 2307.0 13875.0 13932.2 14108.9 14306.3 14396.7 1869.3 1876.7 1933.4 1947.2 1985.5 59598.7 63990.7 65163.7 65340.4 66094.3 15634.6 15660.6 15763.6 15860.6 15923.8 24271.0 24294.6 24408.4 24465.4 24627.0 9148.2 9173.5 9229.2 9253.0 9255.3 7848.2 7882.5 7895.5 7903.1 7909.4 7899.2 7932.3 7934.6 7953.6 7991.4 1797.5 2953.4 3003.7 3066.6 3083.7 835.7 893.9 937.5 979.3 1014.0 16497.9 16801.5 16957.2 16981.9 16995.7 916.6 924.3 956.3 967.8 969.3 9634.4 9757.6 9775.4 9831.9 9870.5 494914.0 496513.0 571544.0 611771.0 617146.0 76662.0 77153.0 77389.0 78544.2 78696.0 1077.1 1079.1 1080.6 1087.7 1090.1 14807.3 14896.8 14971.9 15250.8 15521.8 32250.7 32463.0 33335.3 34328.7 35088.0 39981.4 40226.4 42909.1 43580.8 43818.0 9759.6 9777.3 9779.6 9869.9 10022.3 11832.9 11933.3 12016.9 12036.8 15515.8 11566.4 12196.5 14108.9 14180.9 14494.5 13097.7 13868.2 13890.7 14126.4 14228.6 14109.8 14204.7 14247.1 14645.9 14676.4 9396.7 9521.3 9530.9 9559.6 9591.0 12413.0 14090.9 14334.1 14648.8 14975.3 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | [#3] mootools.html Cycles:180 Average:5113.17 Median:6208.91 stddev:2579.60 (41.5%) stddev-sans-first:2571.72 07:25:13 INFO - PROCESS | 11077 | Values: 1399.0 1450.5 1537.6 1708.2 1709.3 7020.4 7043.6 7159.7 7273.8 7314.2 7258.7 7269.7 7312.5 7319.3 7361.4 2179.4 2215.4 2215.4 2217.9 2221.3 2193.7 2216.3 2237.8 2241.6 2248.9 2189.5 2190.5 2199.6 2231.2 2244.6 2203.2 2227.4 2242.8 2257.4 2258.5 2190.6 2215.1 2216.0 2216.6 2216.9 7094.6 7169.2 7171.9 7192.3 7205.2 4503.1 4551.7 4556.6 4564.3 4584.9 2819.8 2924.8 2927.3 2941.5 2964.1 921.5 926.9 933.3 946.6 969.8 9829.7 9855.2 9860.7 9892.1 9909.4 3960.4 4009.2 4043.4 4047.1 4056.7 8071.1 8073.4 8084.0 8089.6 8095.5 4495.9 4504.3 4512.2 4529.3 4535.0 4129.4 4163.5 4209.2 4210.7 4215.0 3338.5 3367.6 3384.9 3394.0 3398.2 1084.7 1093.5 1093.6 1101.3 1101.3 1052.9 1069.4 1072.9 1195.8 1318.1 6667.9 6698.2 6752.1 6763.3 6772.3 1039.9 1043.4 1051.4 1057.4 1066.8 5557.2 5590.5 5598.0 5604.0 5615.7 8449.0 8536.5 8730.4 8777.8 8806.8 8697.4 8705.0 8715.9 8725.0 8752.4 6890.6 6922.1 7027.6 7035.5 7065.3 6664.3 6694.9 6708.1 6713.0 6774.3 7589.4 7719.4 7851.5 7860.5 7903.7 7998.4 8012.6 8054.7 8088.3 8236.9 6182.9 6234.9 6235.4 6236.9 6242.3 6735.6 6950.8 6976.1 6997.1 7008.3 6434.1 6495.2 6586.4 6638.0 6664.3 6387.3 6429.9 6442.5 6499.9 6522.0 6460.1 6479.9 6522.1 6524.4 6526.8 5952.6 5968.0 5975.7 5977.1 5989.6 6027.6 6119.2 6125.3 6138.2 6155.7 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | [#4] prototype.html Cycles:180 Average:5601.59 Median:6300.38 stddev:1717.94 (27.3%) stddev-sans-first:1676.64 07:25:13 INFO - PROCESS | 11077 | Values: 333.4 334.1 338.8 345.7 349.8 6293.3 6295.2 6311.4 6352.7 6488.0 6300.3 6335.9 6348.8 6357.7 6360.5 4812.2 4813.4 4816.9 4817.1 4826.0 4800.3 4812.0 4820.4 4831.4 4833.6 4659.1 4687.2 4714.4 4715.7 4720.4 4698.0 4702.3 4718.3 4719.1 4724.7 4027.9 4041.4 4054.8 4060.2 4074.4 5973.8 5999.4 6010.2 6038.4 6044.5 5369.7 5561.8 5572.1 5588.3 5600.5 6725.4 6733.9 6739.0 6751.2 6756.1 4595.9 4597.2 4602.0 4614.7 4616.7 6734.9 6934.3 6983.3 6987.4 6989.4 4686.3 4717.6 4722.8 4728.8 4739.6 4764.1 4771.7 4782.8 4791.7 4797.8 5542.9 5548.0 5551.7 5565.0 5569.0 6490.4 6609.9 6661.5 6665.4 6665.6 1633.5 1657.5 1659.8 1662.1 1665.1 1097.9 1117.1 1117.8 1128.9 1134.9 6274.9 6275.3 6287.9 6300.5 6307.6 6807.4 6818.4 6848.6 6854.5 6879.9 6124.2 6238.8 6271.2 6278.2 6284.9 3728.7 3739.6 3740.6 3743.9 3749.5 6937.0 6992.2 6995.9 6996.3 7006.6 7027.8 7049.7 7058.2 7073.0 7077.4 7173.9 7198.4 7202.4 7204.9 7216.6 7039.2 7058.0 7062.3 7078.9 7087.1 6823.2 6999.1 7012.9 7022.1 7031.6 7195.7 7195.7 7213.3 7214.3 7214.7 4636.9 4640.2 4644.2 4647.0 4659.8 6951.6 7048.7 7079.2 7081.6 7131.1 6812.7 6860.0 6865.9 6878.5 6887.0 6850.9 6861.3 6869.8 6873.9 6875.4 6546.7 6630.3 6714.6 6727.4 6741.4 6835.6 6870.2 6887.5 6890.6 6891.4 6591.9 6684.8 6695.7 6696.5 6699.1 07:25:13 INFO - PROCESS | 11077 | 07:25:13 INFO - PROCESS | 11077 | [#5] yui.html Cycles:180 Average:13580.23 Median:49017.00 stddev:16292.28 (33.2%) stddev-sans-first:16309.35 07:25:13 INFO - PROCESS | 11077 | Values: 716.2 775.8 788.5 824.7 839.7 13021.9 13041.4 13172.3 13224.1 13242.1 11716.2 12484.8 12556.7 12559.1 12574.6 800.5 834.2 845.3 845.8 846.9 821.6 829.1 829.8 830.0 830.2 875.6 880.5 881.0 881.2 881.7 865.4 865.7 866.4 869.1 871.1 641.6 643.1 643.2 645.6 646.0 12576.1 12682.9 12708.9 12718.0 12719.5 11874.4 11953.1 11976.9 12103.0 12169.6 10130.8 10391.7 10561.9 10566.3 10639.3 3600.5 3606.2 3646.0 3656.1 3746.1 48565.3 48982.0 49052.0 49412.0 49450.3 9448.8 9489.4 9872.5 10073.2 10169.8 17699.3 17721.8 17739.2 17740.6 17844.6 7573.3 7636.5 7677.5 7731.3 7745.6 4121.8 4334.3 4357.7 4392.6 4406.0 2968.3 2987.4 2994.9 2999.6 3014.1 514.7 515.5 529.9 531.3 535.0 542.9 561.6 601.8 643.1 645.3 7838.1 8051.0 8500.1 8877.7 8993.0 512.7 598.7 623.1 626.7 704.0 3972.8 4015.7 4053.4 4102.9 4130.2 57634.4 61362.0 61373.0 61496.7 61517.4 51187.5 51424.7 51641.2 52528.5 52537.7 46046.3 46291.8 46541.0 46550.8 47290.3 7661.8 7830.0 7918.4 7960.1 8009.8 33730.8 34094.3 34293.5 34935.8 35103.3 40779.2 40873.6 43891.0 46211.8 46707.5 9522.2 10002.3 10078.2 10370.4 10396.6 10799.8 10935.8 11016.6 11143.6 11717.5 9860.9 10011.6 10355.9 10888.2 10924.1 9971.9 10006.7 10080.6 10142.4 10176.2 10004.4 10396.5 10421.2 10504.9 10536.5 8568.5 8597.8 8730.5 8854.0 9017.5 7672.8 7727.4 7893.2 8142.2 8288.5 07:25:13 INFO - PROCESS | 11077 | -------- Summary: end -------- 07:25:13 INFO - PROCESS | 11077 | 07:25:14 INFO - TEST-INFO | 11077: exit 0 07:25:14 INFO - TEST-OK | dromaeo_css | took 1112753ms 07:25:14 INFO - TEST-START | kraken 07:25:14 INFO - operating with platform_type : linux_ 07:25:14 INFO - Initialising browser for kraken test... 07:25:14 INFO - TEST-INFO | started process 11324 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCSo2Gz/profile http://localhost:33745/getInfo.html) 07:25:20 INFO - PROCESS | 11324 | __metrics Screen width/height:1600/1200 07:25:20 INFO - PROCESS | 11324 | colorDepth:24 07:25:20 INFO - PROCESS | 11324 | Browser inner width/height: 1024/697 07:25:20 INFO - PROCESS | 11324 | __metrics 07:25:20 INFO - PROCESS | 11324 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:25:21 INFO - TEST-INFO | 11324: exit 0 07:25:21 INFO - Browser initialized. 07:25:21 INFO - Running cycle 1/1 for kraken test... 07:25:21 INFO - TEST-INFO | started process 11449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCSo2Gz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:33 INFO - PROCESS | 11449 | RSS: Main: 149671936 07:25:33 INFO - PROCESS | 11449 | 07:25:35 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:36 INFO - PROCESS | 11449 | RSS: Main: 151597056 07:25:36 INFO - PROCESS | 11449 | 07:25:38 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-dft) 07:25:39 INFO - PROCESS | 11449 | RSS: Main: 151486464 07:25:39 INFO - PROCESS | 11449 | 07:25:42 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-fft) 07:25:42 INFO - PROCESS | 11449 | RSS: Main: 144678912 07:25:42 INFO - PROCESS | 11449 | 07:25:44 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-oscillator) 07:25:45 INFO - PROCESS | 11449 | RSS: Main: 145416192 07:25:45 INFO - PROCESS | 11449 | 07:25:47 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:48 INFO - PROCESS | 11449 | RSS: Main: 145559552 07:25:48 INFO - PROCESS | 11449 | 07:25:51 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33745/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:51 INFO - PROCESS | 11449 | RSS: Main: 145985536 07:25:51 INFO - PROCESS | 11449 | 07:25:55 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33745/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:55 INFO - PROCESS | 11449 | RSS: Main: 147668992 07:25:55 INFO - PROCESS | 11449 | 07:25:58 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33745/tests/kraken/driver.html?testName=json-parse-financial) 07:25:59 INFO - PROCESS | 11449 | RSS: Main: 148250624 07:25:59 INFO - PROCESS | 11449 | 07:26:00 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:01 INFO - PROCESS | 11449 | RSS: Main: 148889600 07:26:01 INFO - PROCESS | 11449 | 07:26:03 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:03 INFO - PROCESS | 11449 | RSS: Main: 147476480 07:26:03 INFO - PROCESS | 11449 | 07:26:05 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:06 INFO - PROCESS | 11449 | RSS: Main: 147460096 07:26:06 INFO - PROCESS | 11449 | 07:26:08 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:09 INFO - PROCESS | 11449 | RSS: Main: 147820544 07:26:09 INFO - PROCESS | 11449 | 07:26:12 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:12 INFO - PROCESS | 11449 | RSS: Main: 149299200 07:26:12 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33745/tests/kraken/driver.html?testName=ai-astar) 07:26:14 INFO - PROCESS | 11449 | RSS: Main: 149073920 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | __start_tp_report 07:26:14 INFO - PROCESS | 11449 | _x_x_mozilla_page_load 07:26:14 INFO - PROCESS | 11449 | _x_x_mozilla_page_load_details 07:26:14 INFO - PROCESS | 11449 | |i|pagename|runs| 07:26:14 INFO - PROCESS | 11449 | |0;ai-astar;114;107;111;111;111;122;113;112;113;112 07:26:14 INFO - PROCESS | 11449 | |1;audio-beat-detection;153;124;153;161;125;173;152;127;167;127 07:26:14 INFO - PROCESS | 11449 | |2;audio-dft;161;162;160;164;161;161;162;163;170;161 07:26:14 INFO - PROCESS | 11449 | |3;audio-fft;72;72;75;75;73;133;73;71;73;72 07:26:14 INFO - PROCESS | 11449 | |4;audio-oscillator;96;97;142;95;97;96;142;97;97;145 07:26:14 INFO - PROCESS | 11449 | |5;imaging-gaussian-blur;110;111;113;110;111;110;110;111;109;110 07:26:14 INFO - PROCESS | 11449 | |6;imaging-darkroom;146;147;148;148;147;148;147;147;147;147 07:26:14 INFO - PROCESS | 11449 | |7;imaging-desaturate;98;97;98;96;96;97;96;96;96;96 07:26:14 INFO - PROCESS | 11449 | |8;json-parse-financial;61;60;60;59;61;64;62;59;58;59 07:26:14 INFO - PROCESS | 11449 | |9;json-stringify-tinderbox;68;70;69;67;69;68;67;68;67;69 07:26:14 INFO - PROCESS | 11449 | |10;stanford-crypto-aes;87;87;87;86;86;85;85;86;88;86 07:26:14 INFO - PROCESS | 11449 | |11;stanford-crypto-ccm;121;137;130;126;136;130;128;124;128;120 07:26:14 INFO - PROCESS | 11449 | |12;stanford-crypto-pbkdf2;141;152;165;153;156;155;153;153;151;140 07:26:14 INFO - PROCESS | 11449 | |13;stanford-crypto-sha256-iterative;68;69;71;68;70;70;70;68;68;68 07:26:14 INFO - PROCESS | 11449 | __end_tp_report 07:26:14 INFO - PROCESS | 11449 | __start_cc_report 07:26:14 INFO - PROCESS | 11449 | _x_x_mozilla_cycle_collect,725 07:26:14 INFO - PROCESS | 11449 | __end_cc_report 07:26:14 INFO - PROCESS | 11449 | __startTimestamp1451489174780__endTimestamp 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | ------- Summary: start ------- 07:26:14 INFO - PROCESS | 11449 | Number of tests: 14 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:3.81 (3.4%) stddev-sans-first:4.00 07:26:14 INFO - PROCESS | 11449 | Values: 114.0 107.0 111.0 111.0 111.0 122.0 113.0 112.0 113.0 112.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:18.78 (12.3%) stddev-sans-first:19.76 07:26:14 INFO - PROCESS | 11449 | Values: 153.0 124.0 153.0 161.0 125.0 173.0 152.0 127.0 167.0 127.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 07:26:14 INFO - PROCESS | 11449 | Values: 161.0 162.0 160.0 164.0 161.0 161.0 162.0 163.0 170.0 161.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:19.05 (26.1%) stddev-sans-first:20.04 07:26:14 INFO - PROCESS | 11449 | Values: 72.0 72.0 75.0 75.0 73.0 133.0 73.0 71.0 73.0 72.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.50 stddev:22.52 (23.3%) stddev-sans-first:23.28 07:26:14 INFO - PROCESS | 11449 | Values: 96.0 97.0 142.0 95.0 97.0 96.0 142.0 97.0 97.0 145.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:1.08 (1.0%) stddev-sans-first:1.13 07:26:14 INFO - PROCESS | 11449 | Values: 110.0 111.0 113.0 110.0 111.0 110.0 110.0 111.0 109.0 110.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 07:26:14 INFO - PROCESS | 11449 | Values: 146.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 07:26:14 INFO - PROCESS | 11449 | Values: 98.0 97.0 98.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:1.77 (2.9%) stddev-sans-first:1.86 07:26:14 INFO - PROCESS | 11449 | Values: 61.0 60.0 60.0 59.0 61.0 64.0 62.0 59.0 58.0 59.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 07:26:14 INFO - PROCESS | 11449 | Values: 68.0 70.0 69.0 67.0 69.0 68.0 67.0 68.0 67.0 69.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 07:26:14 INFO - PROCESS | 11449 | Values: 87.0 87.0 87.0 86.0 86.0 85.0 85.0 86.0 88.0 86.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.00 stddev:5.64 (4.4%) stddev-sans-first:5.38 07:26:14 INFO - PROCESS | 11449 | Values: 121.0 137.0 130.0 126.0 136.0 130.0 128.0 124.0 128.0 120.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:153.00 stddev:7.17 (4.7%) stddev-sans-first:6.43 07:26:14 INFO - PROCESS | 11449 | Values: 141.0 152.0 165.0 153.0 156.0 155.0 153.0 153.0 151.0 140.0 07:26:14 INFO - PROCESS | 11449 | 07:26:14 INFO - PROCESS | 11449 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 07:26:14 INFO - PROCESS | 11449 | Values: 68.0 69.0 71.0 68.0 70.0 70.0 70.0 68.0 68.0 68.0 07:26:14 INFO - PROCESS | 11449 | -------- Summary: end -------- 07:26:14 INFO - PROCESS | 11449 | 07:26:15 INFO - TEST-INFO | 11449: exit 0 07:26:15 INFO - TEST-OK | kraken | took 61135ms 07:26:15 INFO - TEST-START | v8_7 07:26:15 INFO - operating with platform_type : linux_ 07:26:15 INFO - Initialising browser for v8_7 test... 07:26:15 INFO - TEST-INFO | started process 11736 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzen1Ss/profile http://localhost:33745/getInfo.html) 07:26:21 INFO - PROCESS | 11736 | __metrics Screen width/height:1600/1200 07:26:21 INFO - PROCESS | 11736 | colorDepth:24 07:26:21 INFO - PROCESS | 11736 | Browser inner width/height: 1024/697 07:26:21 INFO - PROCESS | 11736 | __metrics 07:26:21 INFO - PROCESS | 11736 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:26:21 INFO - PROCESS | 11736 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 07:26:22 INFO - TEST-INFO | 11736: exit 0 07:26:22 INFO - Browser initialized. 07:26:22 INFO - Running cycle 1/1 for v8_7 test... 07:26:22 INFO - TEST-INFO | started process 11857 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzen1Ss/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:34 INFO - PROCESS | 11857 | RSS: Main: 149516288 07:26:34 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | Cycle 1(1): loaded http://localhost:33745/tests/v8_7/run.html (next: http://localhost:33745/tests/v8_7/run.html) 07:26:55 INFO - PROCESS | 11857 | RSS: Main: 146046976 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | __start_tp_report 07:26:55 INFO - PROCESS | 11857 | _x_x_mozilla_page_load 07:26:55 INFO - PROCESS | 11857 | _x_x_mozilla_page_load_details 07:26:55 INFO - PROCESS | 11857 | |i|pagename|runs| 07:26:55 INFO - PROCESS | 11857 | |0;Richards;170.8233686368295 07:26:55 INFO - PROCESS | 11857 | |1;DeltaBlue;187.89928598271325 07:26:55 INFO - PROCESS | 11857 | |2;Encrypt;279.79854504756577 07:26:55 INFO - PROCESS | 11857 | |3;Decrypt;5218.75 07:26:55 INFO - PROCESS | 11857 | |4;RayTrace;1070.6638115631692 07:26:55 INFO - PROCESS | 11857 | |5;Earley;709.2198581560284 07:26:55 INFO - PROCESS | 11857 | |6;Boyer;12382.716049382716 07:26:55 INFO - PROCESS | 11857 | |7;RegExp;25300 07:26:55 INFO - PROCESS | 11857 | |8;Splay;680.7351940095303 07:26:55 INFO - PROCESS | 11857 | |9;NavierStokes;4840.579710144928 07:26:55 INFO - PROCESS | 11857 | __end_tp_report 07:26:55 INFO - PROCESS | 11857 | __startTimestamp1451489215725__endTimestamp 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | ------- Summary: start ------- 07:26:55 INFO - PROCESS | 11857 | Number of tests: 10 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#0] Richards Cycles:1 Average:170.82 Median:170.82 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 170.8 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#1] DeltaBlue Cycles:1 Average:187.90 Median:187.90 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 187.9 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 279.8 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 5218.8 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 1070.7 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 709.2 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 12382.7 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#7] RegExp Cycles:1 Average:25300.00 Median:25300.00 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 25300.0 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#8] Splay Cycles:1 Average:680.74 Median:680.74 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 680.7 07:26:55 INFO - PROCESS | 11857 | 07:26:55 INFO - PROCESS | 11857 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:26:55 INFO - PROCESS | 11857 | Values: 4840.6 07:26:55 INFO - PROCESS | 11857 | -------- Summary: end -------- 07:26:55 INFO - PROCESS | 11857 | 07:26:56 INFO - TEST-INFO | 11857: exit 0 07:26:56 INFO - TEST-OK | v8_7 | took 40956ms 07:26:56 INFO - SUITE-END | took 1214s 07:26:56 INFO - Completed test suite (00:20:14) 07:26:56 INFO - Working with test: dromaeo_css 07:26:56 INFO - Generating results file: dromaeo_css 07:26:56 INFO - Working with test: kraken 07:26:56 INFO - Generating results file: kraken 07:26:56 INFO - javascript benchmark 07:26:56 INFO - Working with test: v8_7 07:26:56 INFO - Generating results file: v8_7 07:26:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:26:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:26:56 INFO - process_Request line: dromaeo_css 7021.02 graph.html#tests=[[72,1,43]] 07:26:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:26:56 INFO - process_Request line: kraken 1528.60 graph.html#tests=[[232,1,43]] 07:26:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:26:56 INFO - process_Request line: v8_7 21036.84 graph.html#tests=[[230,1,43]] 07:26:56 INFO - RETURN: dromaeo_css: 7021.02 07:26:56 INFO - RETURN: kraken: 1528.60 07:26:56 INFO - RETURN: v8_7: 21036.84 07:26:56 INFO - javascript benchmark 07:26:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3176.9999999999995, 3236.0130160301114, 3246.594175728034, 3278.70491655751, 3287.1124796304985, 5263.552598029172, 5332.3068001159845, 5359.651622644526, 5362.8123015694455, 5381.300430943977, 5320.308359913206, 5350.063738845696, 5414.43148469411, 5464.508194262516, 5473.233747275374, 4644.233701439275, 4920.655554111214, 5031.496850314976, 5033.219850923113, 5054.646174767768, 4806.279058141272, 4964.87587810304, 4995.125852975733, 5028.245763135523, 5052.79788808449, 4849.5877850382585, 4901.509849015106, 4907.1657818171, 4939.8024079036795, 4949.727764972925, 4881.999190166008, 4894.632902532324, 4902.044101400228, 4915.926261106087, 4931.926021109686, 4849.466558678542, 4896.975515122402, 4919.7540122993705, 4921.704697718148, 4921.852344429637, 5129.9743501282255, 5185.507376799235, 5204.9479505204845, 5271.341082364705, 5289.206619007141, 5842.795502157446, 5851.683371241479, 5854.326752423441, 5870.11948207768, 5873.44202300785, 5862.794802181946, 5878.911816322759, 5883.941160588382, 5887.5584331174905, 5896.557758168155, 5428.809991650312, 5439.0209762242785, 5440.211169380457, 5487.972560137214, 5541.6120871539415, 5817.476427121579, 5877.5591830612875, 5917.615355001911, 5921.28944526651, 5930.762769489258, 5701.059325211377, 5724.542036637059, 5732.541396688255, 5745.482906538348, 5800.59395842287, 5714.9714251429305, 5789.971050144806, 5801.216835727123, 5886.440788125121, 5893.0, 5785.566082543826, 5822.243108395882, 5822.272215973004, 5822.563307751935, 5828.912566311508, 5799.565032622486, 5808.128780682931, 5809.6223745457255, 5814.156947242626, 5835.503982161479, 4390.517043125254, 4415.933760993587, 4460.620847227957, 4472.485664148599, 4513.909721805546, 3969.7221194516105, 3980.8009599520487, 3990.1421194443333, 4002.4996875390575, 4027.033511957109, 5315.548178404802, 5379.919301210407, 5382.542483888835, 5394.460553944574, 5423.945760542423, 5698.401667824902, 5736.483716465455, 5758.654480731169, 5786.450287222707, 5811.27359080115, 5322.680639161663, 5360.892782144335, 5363.383210930715, 5375.919361209585, 5379.488948549882, 4846.5638092571135, 4957.529034741766, 4974.452810190876, 4994.126027945095, 5000.724960127228, 5811.476967072984, 5931.228940237742, 5969.253843269678, 5987.820365389045, 6031.0, 5761.798337058183, 5784.768609255582, 5803.303603567599, 5814.360420353673, 5829.59192856496, 5776.537876969916, 5874.353821079592, 5881.147233651182, 5885.087811389241, 5899.439553242435, 5744.396838331915, 5824.126381042708, 5829.300483941955, 5832.096025116114, 5887.1757953885635, 5933.495652869382, 5933.970330148321, 5974.910376344272, 5985.521158307238, 6010.669413182142, 5555.916661250165, 5622.044252477007, 5643.548516118783, 5765.135229715576, 5774.8845023098465, 5726.885462290647, 5739.655620662774, 5750.482456578928, 5775.624584402, 5823.563232757476, 5595.300587426572, 5636.633618814764, 5654.7455364509515, 5658.122990936411, 5670.971645141748, 5639.915401269066, 5758.856028599319, 5763.538916886723, 5766.077427611562, 5769.74036168365, 5560.388357280777, 5620.297462817148, 5633.915491267552, 5649.54803615718, 5659.6887171204335], "unit": "score", "name": "dojo.html", "value": 5349.984699085576}, {"lowerIsBetter": false, "replicates": [519.3741541442562, 525.4902744337993, 541.9214213938978, 551.8493940134819, 565.2087078090675, 36147.4577881332, 37187.0, 37314.440283395736, 37429.81285093578, 37431.25137497248, 40784.79607601958, 41108.58891411085, 41238.0, 41270.0, 41560.0, 8533.232009119178, 8670.263027642657, 8706.608202630865, 8708.695195668153, 8737.694180703676, 8383.413161078726, 8429.536375499376, 8445.831083378329, 8446.324294056492, 8517.72234164877, 8711.0, 8785.604647790833, 8844.646214151426, 8847.0, 8851.911480885205, 8706.0, 8715.782105447352, 8750.518721470316, 8801.251893589053, 8836.779080522974, 8614.52620105894, 8702.477851328877, 8738.73783786481, 8739.257163141141, 8743.956280218621, 39337.803310983545, 39479.80260098681, 39690.007749806195, 39728.40407393892, 39800.60199397998, 3354.781939173946, 3444.621091679913, 3525.435930251173, 3983.1237127831832, 3998.5001874765653, 29904.55143172854, 30156.849215754, 30183.547246791317, 30228.0, 30327.090187294416, 3833.691429025115, 3914.2954268231706, 3967.761934283952, 3995.720299579031, 4043.353063509824, 258263.0, 259823.0, 260234.69882650467, 260374.0, 263107.9999999981, 53313.73343133259, 53901.0, 57558.424415755304, 57966.0, 60950.39049609536, 55990.44009559934, 56366.0, 56460.0, 56664.0, 56672.43327566754, 15294.694106118039, 15433.614159646098, 15447.613809654624, 15526.456574019856, 15551.766723499157, 11722.120840936965, 11726.70683232909, 11818.054555635528, 11829.881701182878, 11855.0, 19553.315633952745, 19855.503612409517, 20385.18459261613, 20506.794932050787, 20535.075921583564, 7605.277498637621, 7678.5392876427595, 7726.6092103421925, 7759.146493885668, 7872.645730942121, 925.8009527951388, 1015.5176291261739, 1049.7690508088208, 1057.751428414322, 1126.1722633864103, 25430.618540721905, 25557.74442255591, 25754.0, 25930.740692592834, 26008.829602667924, 1031.8813336466403, 1059.560282482761, 1098.9505472253768, 1137.590467431724, 1143.5540139345662, 13713.520026799015, 13800.861991379958, 13819.447222111003, 14005.929970350084, 14089.859101408854, 264692.0, 267375.0, 269832.0, 269935.0, 270600.0, 51698.22452663213, 52806.471935280926, 52825.207621885704, 52904.0, 52926.0, 1319.6436962020393, 1327.044527939901, 1329.8537160912292, 1335.2989680417859, 1338.1034706746502, 25567.232983009795, 26840.328991774582, 26861.597076044265, 27212.0, 27285.727142729113, 45029.09941801211, 45221.0, 45364.77317613391, 45451.545484546055, 45703.77148114238, 309888.0, 310065.0, 311839.0, 312583.0, 312991.0, 31727.524087139172, 31807.204819879687, 32553.34893302168, 32603.184920376232, 32901.50647740238, 38101.809490952364, 38923.2215355697, 39062.2187556253, 39070.21859562736, 40053.599464006154, 33664.49503257404, 35964.10089747777, 36553.0, 37806.24387512289, 37911.62088379081, 31990.36019279555, 32953.67046329602, 33069.17327066843, 33372.33255334928, 33588.1602959928, 32676.83661581677, 32830.0, 33102.172445688084, 33153.668463316026, 33255.833720831244, 29043.85478072596, 29364.706352937053, 30421.543676844423, 31090.22274443157, 31121.533177002817, 22970.770292296864, 24507.38731531726, 24698.876505617358, 24744.752552474965, 24915.626265606392], "unit": "score", "name": "ext.html", "value": 18066.40243077276}, {"lowerIsBetter": false, "replicates": [357.1143563961374, 357.5661596996045, 357.99999999999994, 360.81057444841474, 363.5891442669783, 16917.83082169178, 17370.0, 17747.82252177478, 17998.82001179988, 18284.634307313845, 16197.676046479093, 16341.428050018252, 16441.506754797345, 16486.917565412157, 16930.0, 4906.681065730725, 4991.825286114987, 5016.423111342206, 5033.697978121306, 5038.823641172559, 4377.47470303564, 5005.6496045276845, 5021.9748901255625, 5050.949490505103, 5052.393712754475, 5023.949760502384, 5167.638265321429, 5182.274481572583, 5406.783728650869, 5449.618526703132, 5049.520295571896, 5066.949330506684, 5101.030804147237, 5104.6937183768905, 6179.104029915637, 6009.038553831366, 6103.176071230371, 6114.633122012693, 6117.480014198798, 6146.35463276354, 21038.894805526026, 21301.0, 21527.246546370803, 22399.216027439124, 22489.32532024042, 2181.4328274648547, 2181.530970841277, 2201.0, 2253.3803204118835, 2306.976930230693, 13875.0, 13932.164070155823, 14108.87129029675, 14306.28468576567, 14396.712065758731, 1869.2896699254197, 1876.7278744581959, 1933.3523269704526, 1947.1627200303863, 1985.4639247403265, 59598.68045737556, 63990.68004659947, 65163.67418162926, 65340.36649083763, 66094.3390566093, 15634.609134771721, 15660.608484787743, 15763.605909852346, 15860.60348491297, 15923.761143582855, 24271.0, 24294.635580466307, 24408.389790255387, 24465.38836529101, 24627.0, 9148.222401095982, 9173.541322933826, 9229.16937475617, 9253.0, 9255.305852061123, 7848.215178482106, 7882.5270483771155, 7895.486793358414, 7903.130655627876, 7909.406794490436, 7899.249571290718, 7932.286094251545, 7934.642941067666, 7953.562554059582, 7991.440599158003, 1797.4607617714632, 2953.42408230393, 3003.7296643302207, 3066.5860108885013, 3083.7070478304527, 835.7492752174323, 893.9284857211537, 937.475013992153, 979.3487330924855, 1013.9898601014042, 16497.91751041237, 16801.495955121365, 16957.236924338187, 16981.915090424467, 16995.74506382405, 916.5600511754395, 924.3113880159324, 956.3449037409397, 967.777411195429, 969.2585172343163, 9634.421934683942, 9757.609695612096, 9775.364601300893, 9831.901680983241, 9870.457124858201, 494914.0, 496513.0, 571544.0, 611771.0, 617146.0, 76662.0, 77153.0, 77389.0, 78544.21455785484, 78696.0, 1077.06833588945, 1079.0666073846223, 1080.5677728908342, 1087.690008347617, 1090.1006669497538, 14807.33366998466, 14896.776548351567, 14971.850281497045, 15250.847491524943, 15521.76717349218, 32250.677493224768, 32463.0, 33335.33329333448, 34328.65671343354, 35088.0, 39981.40027899642, 40226.39660405038, 42909.141817164105, 43580.782096089315, 43818.0, 9759.56081976327, 9777.315587908779, 9779.608815647294, 9869.901300987185, 10022.3485473444, 11832.940835295769, 11933.343666098448, 12016.939915300367, 12036.819447708116, 15515.767263491283, 11566.363849987994, 12196.512139514674, 14108.858911410754, 14180.936429767602, 14494.492692755703, 13097.672558186121, 13868.237246951514, 13890.722185556031, 14126.43494260218, 14228.644283892572, 14109.788353174916, 14204.715905682035, 14247.145171289756, 14645.92677036608, 14676.41294348214, 9396.67111651089, 9521.333506654744, 9530.903946046294, 9559.569819358285, 9591.040895910353, 12413.0, 14090.929545352208, 14334.139951602938, 14648.780268295772, 14975.251237438302], "unit": "score", "name": "jquery.html", "value": 9479.967300695655}, {"lowerIsBetter": false, "replicates": [1398.951036713715, 1450.514077783942, 1537.6002239417749, 1708.2483707168853, 1709.3077303692, 7020.438364930806, 7043.612601306926, 7159.749408770694, 7273.818154546132, 7314.232005639411, 7258.745943891965, 7269.74555890544, 7312.451566132535, 7319.2680731926785, 7361.374283185923, 2179.3897708641607, 2215.401841502793, 2215.4350640586626, 2217.944551386212, 2221.255879280443, 2193.7148170737782, 2216.279709094543, 2237.7538470768204, 2241.6413373860187, 2248.853824501402, 2189.5073608438133, 2190.463336482556, 2199.6260635691892, 2231.1967691631, 2244.6408574628063, 2203.22886989554, 2227.40973641985, 2242.798148166673, 2257.4356410897194, 2258.4692597239637, 2190.605690975624, 2215.1139544182297, 2215.9556808863895, 2216.5899308627954, 2216.8891555422165, 7094.609796461193, 7169.24722904098, 7171.89242161368, 7192.2807719228185, 7205.243449437786, 4503.144402563503, 4551.704139230973, 4556.589906908394, 4564.292534657134, 4584.931226031579, 2819.8167119137397, 2924.824510529375, 2927.3413481966386, 2941.485240082977, 2964.125582953034, 921.4747593871496, 926.8795056642593, 933.3280038372361, 946.5787724462617, 969.8254314223437, 9829.655962041366, 9855.162311203556, 9860.704178874645, 9892.071046146004, 9909.40543567381, 3960.4257382679352, 4009.218202450494, 4043.4137050127565, 4047.0894048838777, 4056.6551843093666, 8071.071826739882, 8073.354131669453, 8084.029916410069, 8089.555074470961, 8095.5142691438705, 4495.910081798411, 4504.346869703874, 4512.2329204035395, 4529.297958816389, 4535.047639995571, 4129.380592911088, 4163.479565054368, 4209.200251952119, 4210.7473551587, 4214.978925105354, 3338.499225116252, 3367.5958884933966, 3384.9153771155425, 3394.0496660934978, 3398.150462384404, 1084.6745976207105, 1093.4532733633184, 1093.5680406239492, 1101.3061771084326, 1101.3281898042187, 1052.8631277933819, 1069.417167643636, 1072.8980746829038, 1195.808670612715, 1318.0905175428923, 6667.933320666732, 6698.196216453959, 6752.054712340277, 6763.289854565298, 6772.255051944282, 1039.9168066554657, 1043.3844032020993, 1051.4164638625484, 1057.4289883462998, 1066.7973085113958, 5557.166425036196, 5590.468905453975, 5597.972010139923, 5603.971980140154, 5615.6630602164005, 8449.0, 8536.530490822941, 8730.388872778845, 8777.780555486164, 8806.779830504289, 8697.434666746642, 8704.95647521771, 8715.869261961076, 8725.0, 8752.387332886638, 6890.552114112566, 6922.100126983561, 7027.613481258478, 7035.50751447404, 7065.258147894499, 6664.266930637723, 6694.933050669431, 6708.127943367331, 6712.9664351679885, 6774.254831968578, 7589.43079269046, 7719.382449404146, 7851.489653172754, 7860.528368297921, 7903.723369682033, 7998.360131189607, 8012.639431225725, 8054.718084867001, 8088.312493438124, 8236.917630823615, 6182.938170618237, 6234.875302494015, 6235.407636274546, 6236.875262494634, 6242.344553821783, 6735.5621884579305, 6950.756723514653, 6976.093107896144, 6997.090378250999, 7008.264132266038, 6434.099226108442, 6495.1556297681, 6586.37429444202, 6637.966810165918, 6664.266930637529, 6387.329330420239, 6429.871402571829, 6442.516811239082, 6499.902501462388, 6521.9673901630185, 6460.12788273577, 6479.902801458076, 6522.086907832812, 6524.380183882524, 6526.804195873941, 5952.553558483044, 5968.0, 5975.671338076448, 5977.133315669291, 5989.64062156272, 6027.60820546663, 6119.2350956130485, 6125.264968203844, 6138.202033735586, 6155.692215389123], "unit": "score", "name": "mootools.html", "value": 4240.5303138168365}, {"lowerIsBetter": false, "replicates": [333.3815771743416, 334.1245935648601, 338.83058470764627, 345.71305816172577, 349.8495646871844, 6293.307736149026, 6295.213098362705, 6311.400416960393, 6352.714127864246, 6488.0, 6300.275468321144, 6335.904961425582, 6348.761991411677, 6357.68211589421, 6360.459360954313, 4812.23004319309, 4813.446453657822, 4816.855494335158, 4817.132916075105, 4826.0, 4800.279958006292, 4811.9654274331015, 4820.421549414075, 4831.396075490564, 4833.637477189207, 4659.068186362724, 4687.179743544883, 4714.387129673138, 4715.669903106784, 4720.386349774524, 4697.953020469786, 4702.27114797207, 4718.339432479422, 4719.056188762262, 4724.7401392923375, 4027.939580906289, 4041.3937909313545, 4054.7972601370107, 4060.228556574271, 4074.3684728867074, 5973.761049558012, 5999.370066143036, 6010.158577799111, 6038.426349496791, 6044.546659000593, 5369.6509726867625, 5561.833145005616, 5572.136318870582, 5588.30146231721, 5600.4959553639965, 6725.361090696425, 6733.8653226935185, 6738.966305168492, 6751.189857217166, 6756.121704178426, 4595.931061034087, 4597.195490789099, 4602.0, 4614.676972611918, 4616.676832621718, 6734.93265067348, 6934.341237582422, 6983.266756990493, 6987.44100471956, 6989.370956613879, 4686.320483529869, 4717.646176536773, 4722.787474563653, 4728.810847566059, 4739.644526660514, 4764.118638051971, 4771.73755443454, 4782.784774685148, 4791.736454494967, 4797.832075877328, 5542.944570554324, 5547.972260138674, 5551.666899986014, 5564.998300305984, 5569.0, 6490.415862572391, 6609.933900661028, 6661.500387470959, 6665.366790154928, 6665.566738162004, 1633.4936169787404, 1657.4778944632403, 1659.8008239011153, 1662.069241224918, 1665.1091665958654, 1097.8956999085074, 1117.1230583991528, 1117.80997230471, 1128.949197286124, 1134.914881383883, 6274.874502509924, 6275.341089185661, 6287.905681414691, 6300.479808076806, 6307.558470906993, 6807.353301436356, 6818.386345228953, 6848.589084654936, 6854.485913556404, 6879.931200688029, 6124.173236613089, 6238.781642642486, 6271.216097987752, 6278.183836101278, 6284.874302514016, 3728.7203459740085, 3739.5512538495555, 3740.6259374062374, 3743.887683369503, 3749.512563366745, 6936.965315173392, 6992.16094068715, 6995.930040699528, 6996.300369962963, 7006.649667516604, 7027.8243043923285, 7049.718011279594, 7058.223595404502, 7072.9646351767915, 7077.363037326665, 7173.92826071743, 7198.388137008308, 7202.4238060954995, 7204.92795072053, 7216.603086830275, 7039.1553013638695, 7057.964710176417, 7062.329078737512, 7078.8938165928585, 7087.14954205478, 6823.215330236888, 6999.055127557918, 7012.894806578008, 7022.052022977037, 7031.613261270679, 7195.676194571152, 7195.748148814766, 7213.314735100157, 7214.314640109181, 7214.74748383825, 4636.884077898079, 4640.1879671058105, 4644.164050470948, 4647.047355292225, 4659.836905708284, 6951.582905025714, 7048.682809273698, 7079.1858936223, 7081.575105493687, 7131.072960515307, 6812.659367031728, 6859.965700171467, 6865.931340686529, 6878.518503704692, 6886.965565172142, 6850.862982740417, 6861.279565645735, 6869.793906182823, 6873.931260687529, 6875.3812156906115, 6546.705398256994, 6630.270670226368, 6714.563553369016, 6727.428168605723, 6741.393274605113, 6835.58986460814, 6870.175578930561, 6887.483438742214, 6890.586564806128, 6891.3797758202, 6591.901121483277, 6684.799456016327, 6695.732170713117, 6696.4977626679165, 6699.129113215251], "unit": "score", "name": "prototype.html", "value": 5036.233427491599}, {"lowerIsBetter": false, "replicates": [716.1763971432852, 775.802170446536, 788.4756636836504, 824.6971970231411, 839.6977088248232, 13021.934890325547, 13041.41313640886, 13172.34138293084, 13224.074314797968, 13242.139260948032, 11716.179867409284, 12484.81272780909, 12556.686082847911, 12559.120861539695, 12574.622761317152, 800.4996876951919, 834.1533343656193, 845.3279642684081, 845.8012367093728, 846.8983721953374, 821.6097353756948, 829.1294141151797, 829.8381815545971, 829.9626516806728, 830.2320353672859, 875.5622188905547, 880.5025160784169, 881.0484676549344, 881.22012019363, 881.6737807011415, 865.4158443050916, 865.705660075571, 866.4065115395911, 869.0917990699702, 871.0505548951642, 641.6150309814121, 643.1028714942676, 643.2217017408941, 645.554567348528, 646.034178902539, 12576.11967162299, 12682.936585317015, 12708.872911270953, 12718.0, 12719.491220351174, 11874.406279686067, 11953.103517236243, 11976.92207701311, 12102.971247443978, 12169.634910952596, 10130.797384052277, 10391.740206494822, 10561.894381056169, 10566.260361774679, 10639.255252132354, 3600.4959305697225, 3606.1525541497726, 3645.981770091159, 3656.1042544576485, 3746.119661879456, 48565.271520927214, 48982.0, 49052.0, 49412.0, 49450.25824612634, 9448.763780905394, 9489.38319009276, 9872.45701486425, 10073.194144468425, 10169.796604068026, 17699.292028318723, 17721.822781772276, 17739.201735921913, 17740.55648608795, 17844.643107137785, 7573.2805383488485, 7636.50362726421, 7677.462577619624, 7731.304182623591, 7745.6127193640095, 4121.835126594902, 4334.349847522897, 4357.673174511924, 4392.582704643118, 4406.008648054162, 2968.302448924501, 2987.3875855449583, 2994.8802047918275, 2999.5650630658433, 3014.110837303001, 514.7194778845538, 515.4742162993725, 529.9072662284085, 531.2854211086083, 535.0315928170024, 542.8778524831881, 561.581621691834, 601.8164459839703, 643.0547095769211, 645.2515082504273, 7838.059432867978, 8051.0, 8500.14998500145, 8877.689280875138, 8992.955035224782, 512.6898226572944, 598.6647477412663, 623.0996210475819, 626.743035355502, 704.0354714041694, 3972.7616343019513, 4015.6748273069816, 4053.3717273822604, 4102.938455923164, 4130.153318569686, 57634.42365576374, 61362.0, 61373.0, 61496.69251653802, 61517.38482615117, 51187.488125119016, 51424.74287628538, 51641.225381619304, 52528.47471525312, 52537.7373113132, 46046.309305360446, 46291.768541157755, 46540.99999999932, 46550.76724616355, 47290.29064564034, 7661.846763064819, 7829.960850195713, 7918.3665306776475, 7960.124386317616, 8009.8398032040195, 33730.831345843115, 34094.31811363808, 34293.48559771555, 34935.825320873235, 35103.297934041686, 40779.1844163121, 40873.59126408698, 43891.0, 46211.76894115508, 46707.53292467032, 9522.23822094217, 10002.299839011199, 10078.193744500275, 10370.377777333384, 10396.584136634752, 10799.784004319712, 10935.781284374109, 11016.559337626406, 11143.609973650884, 11717.472713728073, 9860.852087218555, 10011.649592264526, 10355.94822025885, 10888.18338624622, 10924.12606991423, 9971.900280997388, 10006.749831253986, 10080.64717734905, 10142.391456512632, 10176.236782241214, 10004.435562244846, 10396.532156053147, 10421.218408619232, 10504.894951050697, 10536.473176341306, 8568.485890846569, 8597.82804343897, 8730.476171429735, 8854.0, 9017.549122543714, 7672.808179795326, 7727.4204434668745, 7893.210678932061, 8142.226488483585, 8288.544130072903], "unit": "score", "name": "yui.html", "value": 6120.745328197152}], "name": "dromaeo_css", "value": 7021.018959378331}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 111.0, 111.0, 111.0, 122.0, 113.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 153.0, 161.0, 125.0, 173.0, 152.0, 127.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 164.0, 161.0, 161.0, 162.0, 163.0, 170.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 75.0, 73.0, 133.0, 73.0, 71.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 95.0, 97.0, 96.0, 142.0, 97.0, 97.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 113.0, 110.0, 111.0, 110.0, 110.0, 111.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 60.0, 59.0, 61.0, 64.0, 62.0, 59.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 67.0, 69.0, 68.0, 67.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [121.0, 137.0, 130.0, 126.0, 136.0, 130.0, 128.0, 124.0, 128.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.0}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 165.0, 153.0, 156.0, 155.0, 153.0, 153.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 68.0, 70.0, 70.0, 70.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1528.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.8233686368295], "unit": "score", "name": "Richards", "value": 206.65790799999996}, {"lowerIsBetter": false, "replicates": [187.89928598271325], "unit": "score", "name": "DeltaBlue", "value": 351.879996}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [25300.0], "unit": "score", "name": "RegExp", "value": 36.007312252964404}, {"lowerIsBetter": false, "replicates": [680.7351940095303], "unit": "score", "name": "Splay", "value": 119.71027900000001}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21036.84313621878}]} 07:26:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21036.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1528.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7021.02"}}} 07:26:57 INFO - Return code: 0 07:26:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:26:57 INFO - # TBPL SUCCESS # 07:26:57 INFO - Running post-action listener: _resource_record_post_action 07:26:57 INFO - Running post-run listener: _resource_record_post_run 07:26:58 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 24576; Write bytes: 564613120; Read time: 408; Write time: 1756520 07:26:58 INFO - install - Wall time: 17s; CPU: 21.0%; Read bytes: 0; Write bytes: 247365632; Read time: 0; Write time: 1133300 07:26:58 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 24576; Write bytes: 317247488; Read time: 408; Write time: 623220 07:26:58 INFO - Running post-run listener: _upload_blobber_files 07:26:58 INFO - Blob upload gear active. 07:26:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:26:58 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 07:26:58 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:26:58 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:26:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:59 INFO - (blobuploader) - INFO - Done attempting. 07:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:00 INFO - (blobuploader) - INFO - Done attempting. 07:27:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:00 INFO - Return code: 0 07:27:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:27:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f2210dfb1f3360bb8bd84b0821b8fa7d0957951ce5b2ba636517c427bd88ed797ea427e6c2cd103723bd47c2ceb371c63eba3719dabc13ce79536c0b41bc4bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcb842fe9109fc35352115872d37303ef6f77bddc59640c12a4065547532e51669013e8b6b0a34382d7560fee4e86cda5e32b9ecd913d251def7f32e6ad975d7"} 07:27:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:27:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:27:00 INFO - Contents: 07:27:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f2210dfb1f3360bb8bd84b0821b8fa7d0957951ce5b2ba636517c427bd88ed797ea427e6c2cd103723bd47c2ceb371c63eba3719dabc13ce79536c0b41bc4bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcb842fe9109fc35352115872d37303ef6f77bddc59640c12a4065547532e51669013e8b6b0a34382d7560fee4e86cda5e32b9ecd913d251def7f32e6ad975d7"} 07:27:00 INFO - Copying logs to upload dir... 07:27:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.748181 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-30 07:27:00.216727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 07:27:00.219958) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 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/Firefox/sha512/9f2210dfb1f3360bb8bd84b0821b8fa7d0957951ce5b2ba636517c427bd88ed797ea427e6c2cd103723bd47c2ceb371c63eba3719dabc13ce79536c0b41bc4bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcb842fe9109fc35352115872d37303ef6f77bddc59640c12a4065547532e51669013e8b6b0a34382d7560fee4e86cda5e32b9ecd913d251def7f32e6ad975d7"} build_url:https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/W-usqy8oReKlv2V_PH1aGg/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/Firefox/sha512/9f2210dfb1f3360bb8bd84b0821b8fa7d0957951ce5b2ba636517c427bd88ed797ea427e6c2cd103723bd47c2ceb371c63eba3719dabc13ce79536c0b41bc4bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcb842fe9109fc35352115872d37303ef6f77bddc59640c12a4065547532e51669013e8b6b0a34382d7560fee4e86cda5e32b9ecd913d251def7f32e6ad975d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 07:27:00.244543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:27:00.244899) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1451483091.349753-1528929196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:27:00.327490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 07:27:00.327802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 07:27:00.328117) ========= ========= Total master_lag: 0.23 =========