builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1451166744.84 results: success (0) buildid: 20151226113020 builduid: 7a02186b8f8e4ddebd3095ee7f291495 revision: 10ddceabece05224d104081ba4edf7a4a994c9c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.838770) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.839251) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.839542) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006393 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.892010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.892347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.916180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.916463) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004790 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.977440) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.977745) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.978132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:24.978402) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-26 13:52:26-- 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% 225M=0s 2015-12-26 13:52:26 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.224521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.221980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.222329) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015298 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.275093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.275469) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 10ddceabece05224d104081ba4edf7a4a994c9c4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 10ddceabece05224d104081ba4edf7a4a994c9c4 --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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-26 13:52:26,427 truncating revision to first 12 chars 2015-12-26 13:52:26,427 Setting DEBUG logging. 2015-12-26 13:52:26,427 attempt 1/10 2015-12-26 13:52:26,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/10ddceabece0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-26 13:52:26,665 unpacking tar archive at: fx-team-10ddceabece0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509014 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.799038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.799522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.815602) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.815869) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 13:52:25.816549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-26 13:52:25.816831) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:27 INFO - MultiFileLogger online at 20151226 13:52:27 in /builds/slave/test-pgo 13:52:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:52:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:52:27 INFO - {'append_to_log': False, 13:52:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:52:27 INFO - 'blob_upload_branch': 'Fx-Team', 13:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:52:27 INFO - 'branch': 'Fx-Team', 13:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:27 INFO - 'config_files': ('talos/linux_config.py',), 13:52:27 INFO - 'default_actions': ('clobber', 13:52:27 INFO - 'read-buildbot-config', 13:52:27 INFO - 'download-and-extract', 13:52:27 INFO - 'populate-webroot', 13:52:27 INFO - 'create-virtualenv', 13:52:27 INFO - 'install', 13:52:27 INFO - 'run-tests'), 13:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:27 INFO - 'download_minidump_stackwalk': True, 13:52:27 INFO - 'download_symbols': 'ondemand', 13:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:27 INFO - 'installer_path': 'installer.exe', 13:52:27 INFO - 'log_level': 'info', 13:52:27 INFO - 'log_name': 'talos', 13:52:27 INFO - 'log_to_console': True, 13:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:27 INFO - 'opt_config_files': (), 13:52:27 INFO - 'pip_index': False, 13:52:27 INFO - 'sps_profile': False, 13:52:27 INFO - 'sps_profile_interval': 0, 13:52:27 INFO - 'suite': 'dromaeojs', 13:52:27 INFO - 'system_bits': '64', 13:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:27 INFO - 'title': 'talos-linux64-ix-005', 13:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:27 INFO - 'use_talos_json': True, 13:52:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:27 INFO - 'work_dir': 'build'} 13:52:27 INFO - ##### 13:52:27 INFO - ##### Running clobber step. 13:52:27 INFO - ##### 13:52:27 INFO - Running pre-action listener: _resource_record_pre_action 13:52:27 INFO - Running main action method: clobber 13:52:27 INFO - rmtree: /builds/slave/test-pgo/build 13:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:52:27 INFO - Running post-action listener: _resource_record_post_action 13:52:27 INFO - ##### 13:52:27 INFO - ##### Running read-buildbot-config step. 13:52:27 INFO - ##### 13:52:27 INFO - Running pre-action listener: _resource_record_pre_action 13:52:27 INFO - Running main action method: read_buildbot_config 13:52:27 INFO - Using buildbot properties: 13:52:27 INFO - { 13:52:27 INFO - "project": "", 13:52:27 INFO - "product": "firefox", 13:52:27 INFO - "script_repo_revision": "production", 13:52:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:52:27 INFO - "repository": "", 13:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:52:27 INFO - "buildid": "20151226113020", 13:52:27 INFO - "pgo_build": "True", 13:52:27 INFO - "basedir": "/builds/slave/test-pgo", 13:52:27 INFO - "buildnumber": 855, 13:52:27 INFO - "slavename": "talos-linux64-ix-005", 13:52:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:52:27 INFO - "platform": "ubuntu64_hw", 13:52:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:52:27 INFO - "branch": "fx-team", 13:52:27 INFO - "repo_path": "integration/fx-team", 13:52:27 INFO - "revision": "10ddceabece05224d104081ba4edf7a4a994c9c4", 13:52:27 INFO - "stage_platform": "linux64-pgo", 13:52:27 INFO - "builduid": "7a02186b8f8e4ddebd3095ee7f291495", 13:52:27 INFO - "slavebuilddir": "test" 13:52:27 INFO - } 13:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:52:27 INFO - Running post-action listener: _resource_record_post_action 13:52:27 INFO - ##### 13:52:27 INFO - ##### Running download-and-extract step. 13:52:27 INFO - ##### 13:52:27 INFO - Running pre-action listener: _resource_record_pre_action 13:52:27 INFO - Running main action method: download_and_extract 13:52:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:27 INFO - https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/test_packages.json 13:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/test_packages.json 13:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:52:36 INFO - Downloaded 1302 bytes. 13:52:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:52:36 INFO - Using the following test package requirements: 13:52:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:52:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:36 INFO - u'jsshell-linux-x86_64.zip'], 13:52:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:52:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:52:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:52:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:52:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:52:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:36 INFO - https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:38 INFO - Downloaded 23191994 bytes. 13:52:38 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 13:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:52:38 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 13:52:39 INFO - Return code: 0 13:52:39 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 13:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:39 INFO - https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:43 INFO - Downloaded 23191994 bytes. 13:52:43 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 13:52:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:52:43 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 13:52:45 INFO - Return code: 0 13:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:45 INFO - https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:45 INFO - Downloaded 11132270 bytes. 13:52:45 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 13:52:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:45 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 13:52:46 INFO - Return code: 0 13:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:46 INFO - https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:52:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:52:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:52:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/01m3BHFXTA-On70-qjD06w/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 13:52:47 INFO - Downloaded 54918007 bytes. 13:52:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:52:47 INFO - mkdir: /builds/slave/test-pgo/properties 13:52:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:52:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:52:47 INFO - Contents: 13:52:47 INFO - build_url:https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:52:47 INFO - Running post-action listener: _resource_record_post_action 13:52:47 INFO - Running post-action listener: set_extra_try_arguments 13:52:47 INFO - ##### 13:52:47 INFO - ##### Running populate-webroot step. 13:52:47 INFO - ##### 13:52:47 INFO - Running pre-action listener: _resource_record_pre_action 13:52:47 INFO - Running main action method: populate_webroot 13:52:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:52:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:52:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:52:47 INFO - '--tppagecycles', 13:52:47 INFO - '7'], 13:52:47 INFO - 'tests': ['tsvgm']}}, 13:52:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:52:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:52:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:52:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'tests': ['damp', 'tps']}, 13:52:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['damp', 'tps']}, 13:52:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:52:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:47 INFO - 'other': {'tests': ['a11yr', 13:52:47 INFO - 'ts_paint', 13:52:47 INFO - 'tpaint', 13:52:47 INFO - 'sessionrestore', 13:52:47 INFO - 'sessionrestore_no_auto_restore']}, 13:52:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['a11yr', 13:52:47 INFO - 'ts_paint', 13:52:47 INFO - 'tpaint', 13:52:47 INFO - 'sessionrestore', 13:52:47 INFO - 'sessionrestore_no_auto_restore']}, 13:52:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['a11yr', 13:52:47 INFO - 'ts_paint', 13:52:47 INFO - 'tpaint', 13:52:47 INFO - 'sessionrestore', 13:52:47 INFO - 'sessionrestore_no_auto_restore']}, 13:52:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['a11yr', 13:52:47 INFO - 'ts_paint', 13:52:47 INFO - 'tpaint', 13:52:47 INFO - 'sessionrestore', 13:52:47 INFO - 'sessionrestore_no_auto_restore']}, 13:52:47 INFO - 'other_l64': {'tests': ['a11yr', 13:52:47 INFO - 'ts_paint', 13:52:47 INFO - 'tpaint', 13:52:47 INFO - 'sessionrestore', 13:52:47 INFO - 'sessionrestore_no_auto_restore']}, 13:52:47 INFO - 'other_nol64': {'tests': ['a11yr', 13:52:47 INFO - 'ts_paint', 13:52:47 INFO - 'tpaint', 13:52:47 INFO - 'sessionrestore', 13:52:47 INFO - 'sessionrestore_no_auto_restore']}, 13:52:47 INFO - 'svgr': {'tests': ['tsvgx', 13:52:47 INFO - 'tsvgr_opacity', 13:52:47 INFO - 'tart', 13:52:47 INFO - 'tscrollx', 13:52:47 INFO - 'cart']}, 13:52:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['tsvgx', 13:52:47 INFO - 'tsvgr_opacity', 13:52:47 INFO - 'tart', 13:52:47 INFO - 'tscrollx', 13:52:47 INFO - 'cart']}, 13:52:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'tests': ['tp5o']}, 13:52:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'talos_options': ['--e10s'], 13:52:47 INFO - 'tests': ['tp5o']}, 13:52:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'talos_options': ['--xperf_path', 13:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:47 INFO - 'tests': ['tp5n']}, 13:52:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:47 INFO - 'talos_options': ['--e10s', 13:52:47 INFO - '--xperf_path', 13:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:47 INFO - 'tests': ['tp5n']}}, 13:52:47 INFO - 'talos.zip': {'path': '', 13:52:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:52:47 INFO - Running post-action listener: _resource_record_post_action 13:52:47 INFO - ##### 13:52:47 INFO - ##### Running create-virtualenv step. 13:52:47 INFO - ##### 13:52:47 INFO - Running pre-action listener: _resource_record_pre_action 13:52:47 INFO - Running main action method: create_virtualenv 13:52:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:52:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 13:52:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:52:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:47 INFO - Using real prefix '/usr' 13:52:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:52:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:50 INFO - Installing pip.................done. 13:52:50 INFO - Return code: 0 13:52:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:50 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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:50 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 13:52:50 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 13:52:50 INFO - Using env: {'DISPLAY': ':0', 13:52:50 INFO - 'HOME': '/home/cltbld', 13:52:50 INFO - 'LANG': 'en_US.UTF-8', 13:52:50 INFO - 'LANGUAGE': 'en_US:en', 13:52:50 INFO - 'LOGNAME': 'cltbld', 13:52:50 INFO - 'MAIL': '/var/mail/cltbld', 13:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:50 INFO - 'MOZ_NO_REMOTE': '1', 13:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:50 INFO - 'NO_EM_RESTART': '1', 13:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:50 INFO - 'SHELL': '/bin/bash', 13:52:50 INFO - 'SHLVL': '1', 13:52:50 INFO - 'TERM': 'linux', 13:52:50 INFO - 'TMOUT': '86400', 13:52:50 INFO - 'USER': 'cltbld', 13:52:50 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:50 INFO - '_': '/tools/buildbot/bin/python'} 13:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:52:50 INFO - Cleaning up... 13:52:50 INFO - Return code: 0 13:52:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:50 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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:50 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 13:52:50 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 13:52:50 INFO - Using env: {'DISPLAY': ':0', 13:52:50 INFO - 'HOME': '/home/cltbld', 13:52:50 INFO - 'LANG': 'en_US.UTF-8', 13:52:50 INFO - 'LANGUAGE': 'en_US:en', 13:52:50 INFO - 'LOGNAME': 'cltbld', 13:52:50 INFO - 'MAIL': '/var/mail/cltbld', 13:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:50 INFO - 'MOZ_NO_REMOTE': '1', 13:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:50 INFO - 'NO_EM_RESTART': '1', 13:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:50 INFO - 'SHELL': '/bin/bash', 13:52:50 INFO - 'SHLVL': '1', 13:52:50 INFO - 'TERM': 'linux', 13:52:50 INFO - 'TMOUT': '86400', 13:52:50 INFO - 'USER': 'cltbld', 13:52:50 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:50 INFO - '_': '/tools/buildbot/bin/python'} 13:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:50 INFO - Downloading/unpacking psutil>=0.7.1 13:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:52 INFO - Installing collected packages: psutil 13:52:52 INFO - Running setup.py install for psutil 13:52:52 INFO - building 'psutil._psutil_linux' extension 13:52:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:52:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:52:52 INFO - building 'psutil._psutil_posix' extension 13:52:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:52:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:52:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:52 INFO - Successfully installed psutil 13:52:52 INFO - Cleaning up... 13:52:52 INFO - Return code: 0 13:52:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:52:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:52:52 INFO - Using env: {'DISPLAY': ':0', 13:52:52 INFO - 'HOME': '/home/cltbld', 13:52:52 INFO - 'LANG': 'en_US.UTF-8', 13:52:52 INFO - 'LANGUAGE': 'en_US:en', 13:52:52 INFO - 'LOGNAME': 'cltbld', 13:52:52 INFO - 'MAIL': '/var/mail/cltbld', 13:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:52 INFO - 'MOZ_NO_REMOTE': '1', 13:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:52 INFO - 'NO_EM_RESTART': '1', 13:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:52 INFO - 'SHELL': '/bin/bash', 13:52:52 INFO - 'SHLVL': '1', 13:52:52 INFO - 'TERM': 'linux', 13:52:52 INFO - 'TMOUT': '86400', 13:52:52 INFO - 'USER': 'cltbld', 13:52:52 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:52 INFO - '_': '/tools/buildbot/bin/python'} 13:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:52:54 INFO - Installing collected packages: mozsystemmonitor 13:52:54 INFO - Running setup.py install for mozsystemmonitor 13:52:54 INFO - Successfully installed mozsystemmonitor 13:52:54 INFO - Cleaning up... 13:52:54 INFO - Return code: 0 13:52:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:54 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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:54 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 13:52:54 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 13:52:54 INFO - Using env: {'DISPLAY': ':0', 13:52:54 INFO - 'HOME': '/home/cltbld', 13:52:54 INFO - 'LANG': 'en_US.UTF-8', 13:52:54 INFO - 'LANGUAGE': 'en_US:en', 13:52:54 INFO - 'LOGNAME': 'cltbld', 13:52:54 INFO - 'MAIL': '/var/mail/cltbld', 13:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:54 INFO - 'MOZ_NO_REMOTE': '1', 13:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:54 INFO - 'NO_EM_RESTART': '1', 13:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:54 INFO - 'SHELL': '/bin/bash', 13:52:54 INFO - 'SHLVL': '1', 13:52:54 INFO - 'TERM': 'linux', 13:52:54 INFO - 'TMOUT': '86400', 13:52:54 INFO - 'USER': 'cltbld', 13:52:54 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:54 INFO - '_': '/tools/buildbot/bin/python'} 13:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:52:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:57 INFO - Downloading docopt-0.6.1.tar.gz 13:52:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:57 INFO - Running setup.py install for blobuploader 13:52:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:52:57 INFO - Running setup.py install for requests 13:52:57 INFO - Running setup.py install for docopt 13:52:58 INFO - Successfully installed blobuploader requests docopt 13:52:58 INFO - Cleaning up... 13:52:58 INFO - Return code: 0 13:52:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:58 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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:58 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 13:52:58 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 13:52:58 INFO - Using env: {'DISPLAY': ':0', 13:52:58 INFO - 'HOME': '/home/cltbld', 13:52:58 INFO - 'LANG': 'en_US.UTF-8', 13:52:58 INFO - 'LANGUAGE': 'en_US:en', 13:52:58 INFO - 'LOGNAME': 'cltbld', 13:52:58 INFO - 'MAIL': '/var/mail/cltbld', 13:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:58 INFO - 'MOZ_NO_REMOTE': '1', 13:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:58 INFO - 'NO_EM_RESTART': '1', 13:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:58 INFO - 'SHELL': '/bin/bash', 13:52:58 INFO - 'SHLVL': '1', 13:52:58 INFO - 'TERM': 'linux', 13:52:58 INFO - 'TMOUT': '86400', 13:52:58 INFO - 'USER': 'cltbld', 13:52:58 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:58 INFO - '_': '/tools/buildbot/bin/python'} 13:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:58 INFO - Running setup.py (path:/tmp/pip-yj6bU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:58 INFO - Running setup.py (path:/tmp/pip-2ey_og-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:58 INFO - Running setup.py (path:/tmp/pip-uPVEjw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:58 INFO - Running setup.py (path:/tmp/pip-AAqIzt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:58 INFO - Running setup.py (path:/tmp/pip-EkfH2o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:58 INFO - Running setup.py (path:/tmp/pip-nMKSPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:58 INFO - Running setup.py (path:/tmp/pip-SVP2jh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:58 INFO - Running setup.py (path:/tmp/pip-KCUcl3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:58 INFO - Running setup.py (path:/tmp/pip-48wpd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:58 INFO - Running setup.py (path:/tmp/pip-C7hlhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:59 INFO - Running setup.py (path:/tmp/pip-C35Xt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:59 INFO - Running setup.py (path:/tmp/pip-j8Jdet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:59 INFO - Running setup.py (path:/tmp/pip-BenOUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:59 INFO - Running setup.py (path:/tmp/pip-9kHlzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:59 INFO - Running setup.py (path:/tmp/pip-BurndH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:59 INFO - Running setup.py (path:/tmp/pip-ZiF1zV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:59 INFO - Running setup.py (path:/tmp/pip-U9BTwz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:59 INFO - Running setup.py install for manifestparser 13:52:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for mozcrash 13:52:59 INFO - Running setup.py install for mozdebug 13:52:59 INFO - Running setup.py install for mozdevice 13:52:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for mozfile 13:53:00 INFO - Running setup.py install for mozhttpd 13:53:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Running setup.py install for mozinfo 13:53:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Running setup.py install for mozInstall 13:53:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Running setup.py install for mozleak 13:53:00 INFO - Running setup.py install for mozlog 13:53:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Running setup.py install for moznetwork 13:53:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Running setup.py install for mozprocess 13:53:00 INFO - Running setup.py install for mozprofile 13:53:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Running setup.py install for mozrunner 13:53:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Running setup.py install for mozscreenshot 13:53:01 INFO - Running setup.py install for moztest 13:53:01 INFO - Running setup.py install for mozversion 13:53:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:53:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:53:01 INFO - Cleaning up... 13:53:01 INFO - Return code: 0 13:53:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:01 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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:01 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 13:53:01 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 13:53:01 INFO - Using env: {'DISPLAY': ':0', 13:53:01 INFO - 'HOME': '/home/cltbld', 13:53:01 INFO - 'LANG': 'en_US.UTF-8', 13:53:01 INFO - 'LANGUAGE': 'en_US:en', 13:53:01 INFO - 'LOGNAME': 'cltbld', 13:53:01 INFO - 'MAIL': '/var/mail/cltbld', 13:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:01 INFO - 'MOZ_NO_REMOTE': '1', 13:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:01 INFO - 'NO_EM_RESTART': '1', 13:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:01 INFO - 'SHELL': '/bin/bash', 13:53:01 INFO - 'SHLVL': '1', 13:53:01 INFO - 'TERM': 'linux', 13:53:01 INFO - 'TMOUT': '86400', 13:53:01 INFO - 'USER': 'cltbld', 13:53:01 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:01 INFO - '_': '/tools/buildbot/bin/python'} 13:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:01 INFO - Running setup.py (path:/tmp/pip-V3EqAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:01 INFO - Running setup.py (path:/tmp/pip-GMNaJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:01 INFO - Running setup.py (path:/tmp/pip-c88Xn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:01 INFO - Running setup.py (path:/tmp/pip-FJa8Aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:01 INFO - Running setup.py (path:/tmp/pip-MQy324-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:01 INFO - Running setup.py (path:/tmp/pip-kRPzy7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:01 INFO - Running setup.py (path:/tmp/pip-hIk74u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:02 INFO - Running setup.py (path:/tmp/pip-y1P5z0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:02 INFO - Running setup.py (path:/tmp/pip-crm_dP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:02 INFO - Running setup.py (path:/tmp/pip-0G9Eys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:02 INFO - Running setup.py (path:/tmp/pip-SI9JOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:02 INFO - Running setup.py (path:/tmp/pip-q903cS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:02 INFO - Running setup.py (path:/tmp/pip-WgnFyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:02 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)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:02 INFO - Running setup.py (path:/tmp/pip-9InLwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:02 INFO - Running setup.py (path:/tmp/pip-3hXoRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:02 INFO - Running setup.py (path:/tmp/pip-frWm3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:02 INFO - Running setup.py (path:/tmp/pip-rJEdgg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:53:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:04 INFO - Downloading blessings-1.5.1.tar.gz 13:53:04 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 13:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:53:04 INFO - Installing collected packages: blessings 13:53:04 INFO - Running setup.py install for blessings 13:53:04 INFO - Successfully installed blessings 13:53:04 INFO - Cleaning up... 13:53:04 INFO - Return code: 0 13:53:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:53:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:53:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:53:04 INFO - Reading from file tmpfile_stdout 13:53:04 INFO - Current package versions: 13:53:04 INFO - argparse == 1.2.1 13:53:04 INFO - blessings == 1.5.1 13:53:04 INFO - blobuploader == 1.2.4 13:53:04 INFO - docopt == 0.6.1 13:53:04 INFO - manifestparser == 1.1 13:53:04 INFO - mozInstall == 1.12 13:53:04 INFO - mozcrash == 0.16 13:53:04 INFO - mozdebug == 0.1 13:53:04 INFO - mozdevice == 0.47 13:53:04 INFO - mozfile == 1.2 13:53:04 INFO - mozhttpd == 0.7 13:53:04 INFO - mozinfo == 0.9 13:53:04 INFO - mozleak == 0.1 13:53:04 INFO - mozlog == 3.1 13:53:04 INFO - moznetwork == 0.27 13:53:04 INFO - mozprocess == 0.22 13:53:04 INFO - mozprofile == 0.28 13:53:04 INFO - mozrunner == 6.11 13:53:04 INFO - mozscreenshot == 0.1 13:53:04 INFO - mozsystemmonitor == 0.0 13:53:04 INFO - moztest == 0.7 13:53:04 INFO - mozversion == 1.4 13:53:04 INFO - psutil == 3.1.1 13:53:04 INFO - requests == 1.2.3 13:53:04 INFO - wsgiref == 0.1.2 13:53:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:53:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:53:04 INFO - Using env: {'DISPLAY': ':0', 13:53:04 INFO - 'HOME': '/home/cltbld', 13:53:04 INFO - 'LANG': 'en_US.UTF-8', 13:53:04 INFO - 'LANGUAGE': 'en_US:en', 13:53:04 INFO - 'LOGNAME': 'cltbld', 13:53:04 INFO - 'MAIL': '/var/mail/cltbld', 13:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:04 INFO - 'MOZ_NO_REMOTE': '1', 13:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:04 INFO - 'NO_EM_RESTART': '1', 13:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:04 INFO - 'SHELL': '/bin/bash', 13:53:04 INFO - 'SHLVL': '1', 13:53:04 INFO - 'TERM': 'linux', 13:53:04 INFO - 'TMOUT': '86400', 13:53:04 INFO - 'USER': 'cltbld', 13:53:04 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:04 INFO - '_': '/tools/buildbot/bin/python'} 13:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 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)) 13:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:53:05 INFO - Cleaning up... 13:53:05 INFO - Return code: 0 13:53:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:05 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 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:05 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 13:53:05 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 13:53:05 INFO - Using env: {'DISPLAY': ':0', 13:53:05 INFO - 'HOME': '/home/cltbld', 13:53:05 INFO - 'LANG': 'en_US.UTF-8', 13:53:05 INFO - 'LANGUAGE': 'en_US:en', 13:53:05 INFO - 'LOGNAME': 'cltbld', 13:53:05 INFO - 'MAIL': '/var/mail/cltbld', 13:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:05 INFO - 'MOZ_NO_REMOTE': '1', 13:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:05 INFO - 'NO_EM_RESTART': '1', 13:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:05 INFO - 'SHELL': '/bin/bash', 13:53:05 INFO - 'SHLVL': '1', 13:53:05 INFO - 'TERM': 'linux', 13:53:05 INFO - 'TMOUT': '86400', 13:53:05 INFO - 'USER': 'cltbld', 13:53:05 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:05 INFO - '_': '/tools/buildbot/bin/python'} 13:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:05 INFO - Downloading/unpacking jsonschema 13:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:53:06 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 13:53:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53:07 INFO - Downloading functools32-3.2.3-2.tar.gz 13:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:53:07 INFO - warning: no files found matching '*.txt' 13:53:07 INFO - no previously-included directories found matching 'build' 13:53:07 INFO - no previously-included directories found matching 'dist' 13:53:07 INFO - no previously-included directories found matching '.git*' 13:53:07 INFO - Installing collected packages: jsonschema, functools32 13:53:07 INFO - Running setup.py install for functools32 13:53:07 INFO - warning: no files found matching '*.txt' 13:53:07 INFO - no previously-included directories found matching 'build' 13:53:07 INFO - no previously-included directories found matching 'dist' 13:53:07 INFO - no previously-included directories found matching '.git*' 13:53:07 INFO - Successfully installed jsonschema functools32 13:53:07 INFO - Cleaning up... 13:53:07 INFO - Return code: 0 13:53:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f30961f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:53:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:53:07 INFO - Using env: {'DISPLAY': ':0', 13:53:07 INFO - 'HOME': '/home/cltbld', 13:53:07 INFO - 'LANG': 'en_US.UTF-8', 13:53:07 INFO - 'LANGUAGE': 'en_US:en', 13:53:07 INFO - 'LOGNAME': 'cltbld', 13:53:07 INFO - 'MAIL': '/var/mail/cltbld', 13:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:07 INFO - 'MOZ_NO_REMOTE': '1', 13:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:07 INFO - 'NO_EM_RESTART': '1', 13:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:07 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:07 INFO - 'SHELL': '/bin/bash', 13:53:07 INFO - 'SHLVL': '1', 13:53:07 INFO - 'TERM': 'linux', 13:53:07 INFO - 'TMOUT': '86400', 13:53:07 INFO - 'USER': 'cltbld', 13:53:07 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:07 INFO - '_': '/tools/buildbot/bin/python'} 13:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:07 INFO - Downloading/unpacking flake8 13:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:53:09 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 13:53:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:53:09 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 13:53:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:09 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 13:53:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:53:09 INFO - no previously-included directories found matching 'docs/_build' 13:53:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:53:10 INFO - Running setup.py install for pep8 13:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:53:10 INFO - no previously-included directories found matching 'docs/_build' 13:53:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:53:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:53:10 INFO - Cleaning up... 13:53:10 INFO - Return code: 0 13:53:10 INFO - Running post-action listener: _resource_record_post_action 13:53:10 INFO - Running post-action listener: _start_resource_monitoring 13:53:10 INFO - Starting resource monitoring. 13:53:10 INFO - ##### 13:53:10 INFO - ##### Running install step. 13:53:10 INFO - ##### 13:53:10 INFO - Running pre-action listener: _resource_record_pre_action 13:53:10 INFO - Running main action method: install 13:53:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:53:10 INFO - Reading from file tmpfile_stdout 13:53:10 INFO - Detecting whether we're running mozinstall >=1.0... 13:53:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:53:10 INFO - Reading from file tmpfile_stdout 13:53:10 INFO - Output received: 13:53:10 INFO - Usage: mozinstall [options] installer 13:53:10 INFO - Options: 13:53:10 INFO - -h, --help show this help message and exit 13:53:10 INFO - -d DEST, --destination=DEST 13:53:10 INFO - Directory to install application into. [default: 13:53:10 INFO - "/builds/slave/test-pgo"] 13:53:10 INFO - --app=APP Application being installed. [default: firefox] 13:53:10 INFO - mkdir: /builds/slave/test-pgo/build/application 13:53:10 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'] 13:53:10 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 13:53:26 INFO - Reading from file tmpfile_stdout 13:53:26 INFO - Output received: 13:53:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:53:26 INFO - Running post-action listener: _resource_record_post_action 13:53:26 INFO - ##### 13:53:26 INFO - ##### Running run-tests step. 13:53:26 INFO - ##### 13:53:26 INFO - Running pre-action listener: _resource_record_pre_action 13:53:26 INFO - Running main action method: run_tests 13:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:53:26 INFO - Python 2.7.3 13:53:26 INFO - Return code: 0 13:53:26 INFO - grabbing minidump binary from tooltool 13:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:26 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 0x153b540>, '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 0x153c440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153c8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:53:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:53:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:53:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:26 INFO - Return code: 0 13:53:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:53:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:53:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:53:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:53:27 INFO - Return code: 0 13:53:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 13:53:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 13:53:27 INFO - Using env: {'DISPLAY': ':0', 13:53:27 INFO - 'HOME': '/home/cltbld', 13:53:27 INFO - 'LANG': 'en_US.UTF-8', 13:53:27 INFO - 'LANGUAGE': 'en_US:en', 13:53:27 INFO - 'LOGNAME': 'cltbld', 13:53:27 INFO - 'MAIL': '/var/mail/cltbld', 13:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:27 INFO - 'MOZ_NO_REMOTE': '1', 13:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:27 INFO - 'NO_EM_RESTART': '1', 13:53:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:53:27 INFO - 'SHELL': '/bin/bash', 13:53:27 INFO - 'SHLVL': '1', 13:53:27 INFO - 'TERM': 'linux', 13:53:27 INFO - 'TMOUT': '86400', 13:53:27 INFO - 'USER': 'cltbld', 13:53:27 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792', 13:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:27 INFO - '_': '/tools/buildbot/bin/python'} 13:53:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:53:27 INFO - mozversion application_buildid: 20151226113020 13:53:27 INFO - mozversion application_changeset: 10ddceabece05224d104081ba4edf7a4a994c9c4 13:53:27 INFO - mozversion application_display_name: Nightly 13:53:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:27 INFO - mozversion application_name: Firefox 13:53:27 INFO - mozversion application_remotingname: firefox 13:53:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:53:27 INFO - mozversion application_vendor: Mozilla 13:53:27 INFO - mozversion application_version: 46.0a1 13:53:27 INFO - mozversion platform_buildid: 20151226113020 13:53:27 INFO - mozversion platform_changeset: 10ddceabece05224d104081ba4edf7a4a994c9c4 13:53:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:53:27 INFO - mozversion platform_version: 46.0a1 13:53:27 INFO - using testdate: 1451166807 13:53:27 INFO - actual date: 1451166807 13:53:27 INFO - starting webserver on 'localhost:57939' 13:53:27 INFO - SUITE-START | Running 3 tests 13:53:27 INFO - TEST-START | dromaeo_css 13:53:27 INFO - operating with platform_type : linux_ 13:53:27 INFO - Initialising browser for dromaeo_css test... 13:53:27 INFO - TEST-INFO | started process 16180 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDNIMLn/profile http://localhost:57939/getInfo.html) 13:53:31 INFO - PROCESS | 16180 | __metrics Screen width/height:1600/1200 13:53:31 INFO - PROCESS | 16180 | colorDepth:24 13:53:31 INFO - PROCESS | 16180 | Browser inner width/height: 1024/697 13:53:31 INFO - PROCESS | 16180 | __metrics 13:53:31 INFO - PROCESS | 16180 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:53:31 INFO - PROCESS | 16180 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:53:32 INFO - TEST-INFO | 16180: exit 0 13:53:32 INFO - Browser initialized. 13:53:32 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:32 INFO - TEST-INFO | started process 16271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDNIMLn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:44 INFO - PROCESS | 16271 | RSS: Main: 149356544 13:53:44 INFO - PROCESS | 16271 | 13:54:35 INFO - PROCESS | 16271 | 1451166875037 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:56:43 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57939/tests/dromaeo/cssquery-ext.html) 13:56:44 INFO - PROCESS | 16271 | RSS: Main: 287318016 13:56:44 INFO - PROCESS | 16271 | 13:59:47 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-ext.html (next: http://localhost:57939/tests/dromaeo/cssquery-jquery.html) 13:59:47 INFO - PROCESS | 16271 | RSS: Main: 236535808 13:59:47 INFO - PROCESS | 16271 | 14:02:49 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57939/tests/dromaeo/cssquery-mootools.html) 14:02:50 INFO - PROCESS | 16271 | RSS: Main: 222449664 14:02:50 INFO - PROCESS | 16271 | 14:05:52 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57939/tests/dromaeo/cssquery-prototype.html) 14:05:52 INFO - PROCESS | 16271 | RSS: Main: 215367680 14:05:52 INFO - PROCESS | 16271 | 14:08:55 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57939/tests/dromaeo/cssquery-yui.html) 14:08:55 INFO - PROCESS | 16271 | RSS: Main: 219869184 14:08:55 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-yui.html (next: http://localhost:57939/tests/dromaeo/cssquery-dojo.html) 14:11:58 INFO - PROCESS | 16271 | RSS: Main: 238989312 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | __start_tp_report 14:11:58 INFO - PROCESS | 16271 | _x_x_mozilla_page_load 14:11:58 INFO - PROCESS | 16271 | _x_x_mozilla_page_load_details 14:11:58 INFO - PROCESS | 16271 | |i|pagename|runs| 14:11:58 INFO - PROCESS | 16271 | |0;dojo.html;3143.5284707293904;3190.7447404207664;3225.7096861282494;3233.062411900549;3252.5771649685544;5132.332796736419;5250.3699556053325;5262.763175657095;5286.233496143057;5291.021161085202;5147.150720131174;5175.896482070356;5284.39229488608;5344.331958505187;5428.4300148484335;4860.927086093702;4881.585065269456;4903.141950158726;4966.801327946878;4991;312.6816187391453;4722.881927951795;4881.194602890537;4884.951150488485;4954.822210789715;4803.447603525587;4804.327394164819;4862.343583616202;4874.780634871404;4919.680220785637;4874.707517548958;4877.244027175793;4883.609311255091;4888.902221955576;4928.6303527235605;4739.336492890998;4808.591269742076;4838.225883858601;4863.1732605457155;4902.754862256908;5145.382554093533;5158.716270605115;5168.224766285088;5173.198154286091;5179.482051794828;5690.317161940594;5713.257276554063;5715.114157305624;5717.656940583537;5751.971240143815;5570.470805273492;5695.088785794294;5700.116481945305;5748.827535173951;5773.682447465388;5222.477752224785;5251.10731175701;5286.788528458857;5293.285406470116;5296.232046353296;5847.239858818326;5852.8536786579825;5857.531397488191;5860.238169037998;5860.2967643883;5535.059039963136;5571.860703482364;5637.689927054052;5638.379778224392;5642.605017648725;5592.860178495489;5720.971395143081;5773;5795.623284486495;5840.649561026352;5605.439456054362;5675.489205971482;5682.7442765075675;5687.3459552152035;5691.630044047124;5562.3047119110115;5666.886662266732;5689.231953686282;5701.600887937804;5707.942920570824;4341.674374421931;4343.239933011773;4361.80371883266;4364.476262848479;4376.14665140301;3910.608939106067;3933.3116704576582;3936.389859571771;3943.7907911937878;3962.643362097425;5192;5321.095413779667;5345.7594408251725;5355.678659280456;5356.491133342326;5593.46862048113;5601.047821870292;5626.971865140648;5639.492445679908;5654.37801841797;5352.277442545206;5359.598030147755;5373.516383525423;5377.4084850666395;5378;4698.976505117453;4811.542903424239;4816.494268101869;4817.9036419271415;4870.293807397908;5817.650940943557;5875.853103672443;5898.793542226002;5904.380040095814;5959.493443057302;5694.231278777312;5707.6575405475805;5707.714614269187;5713.971485132716;5714.20001199824;5739.110437882135;5845.18167456548;5852.970735146297;5875.177475153568;5885.793997210077;5524.171374293888;5567.66594004361;5583.302087239095;5613.803516876889;5626.915596266142;5631.352394474688;5666.688332141772;5677.687727175045;5688.488036076773;5700.059490184239;5481.506664400223;5488.9725551371985;5546.55627549787;5547.2233887256625;5600.887982240414;5523.254360661259;5569.10894256917;5576.275084239185;5577.498025177591;5628.60599758013;5483.862903427446;5498.917516237339;5499.5325397340075;5500.257465242141;5504.6421982571;5377.704226267593;5455.072637651688;5486.0125177468435;5589.776408943597;5630.127330263816;5483.643563168382;5525.640833345819;5543.196236545759;5543.501084902378;5585.162225666182 14:11:58 INFO - PROCESS | 16271 | |1;ext.html;563.399979022341;577.9682117483538;578.4331355271834;578.9478946894778;582.702821561004;27559.31101722458;28133.437331253415;28160.436791264186;28171.577426338623;28235.717642823565;28853.422931541358;29266.561001584992;36161.0959726007;36533.45199822005;36652;8640.2223799858;8793.252573531257;8797.560121993907;8805.16350946659;8822.911770882305;8645.69740059098;8761.211490965812;8776.341774366949;8777.473351598892;8779.604917778683;7567.470277080606;7726.42051846111;7728.304452599265;7728.343090837286;10182.847257291147;9894.55474503649;9992.750181245527;9996.200303975664;10000.799984000352;10011.299209055333;9875;10000.749981250454;10004.14964727999;10010.54952527138;10016.54925528353;30570.847145764128;31336.21659458509;39433.60566394357;39940.800295998626;40715.59284407148;3240.627327857303;3254.7721659483846;3320.701136897691;3434.1414646338417;3675.7794532328144;26408.735912641012;26560.203193904214;27038;27096.59355109675;27473;3892.727509074366;3913.941290880639;3935.1932853765197;3967.444557761916;4024.879253622396;221181;222162;272514;276630;442768.9999999968;49095.50904490909;49349.75325123352;49405;49830.75084624554;49852.75073624609;51824.22263666048;51888.48111518912;51987;51988.02137754206;52176.21735673968;14375.712485750435;14417.207053612152;14459.78310325346;14501.854981450051;14577.271136443347;10435.16518678504;10435.634752783617;10458.372497650165;10463.947680261703;10468.581256749798;18375.72436413455;18377.43791777687;18411.171497282656;18427.63144737098;18454.26182952667;7544.207858174922;7642.312191902755;7823.374130069581;7830.6084695764985;7865.842683146419;987.9259055570861;999.8700168978132;1006.2000709436016;1037.838911510583;1081.9667217807132;28175.15474535767;28616.427671446454;28730.425391492052;29046.854765726457;29164;1041.7864337810731;1051.8632577764843;1068.124138206663;1071.7802850415646;1104.5416152296707;14996.400143994337;15104.773428398583;15220.619484512754;15226.390944362323;15367.769483457758;309483;314373;314760;314941;315102;42706.57293427088;42753.78623106865;42775.78612106982;42798.57201428008;42812.143757124686;1322.7751282282036;1326.5025615394227;1333.1667707682698;1340.8726171013739;1349.0421800521544;27672.723272767016;28283;28430.57354139731;28482.287942800765;28648.570271446362;41102.58897411107;42529.36205956975;44883.77558112319;46223.53776462192;46282.53717462917;243600;243723;244926;245582;246702;26506.867465662548;26980.1905942822;29317.26706832346;30654.386912262074;31304.373912521165;36637.81681091578;37304.44043339298;37362.8131859339;38038.61961380351;38252.80873595614;31652.525212121374;31898.6810131905;32047.198820029687;33380.33239335248;35511.64488355187;33976.15059623529;34441.48337774885;35296.82351588328;35480.645193548764;35660.821695891354;34060.489092664124;34259.828700856335;34861.9541413758;34889;34904.65095349115;29646;29706.851465742533;31724.20689482689;31960.52059219067;32030.679693203703;24623;24677.259682209562;24680.876595616908;24962.62556061624;25203.369915752253 14:11:58 INFO - PROCESS | 16271 | |2;jquery.html;315.24027094701745;315.47158509496603;318.95853539039916;322.23147792514845;328.55644879412796;13726.519571814964;14105.435782568711;15698.607534811636;16143.304952979945;16362.999999999985;15442.227888605554;15766;16459.917700411483;16521.173941302917;16537.91731041346;4480.955190448095;5248.21276808478;5268.473152684739;5272.657277276984;5274.762635681384;3801.201747633;3898;5225.033368826779;5591.049521581341;5737.856553586173;5628.127640215753;5647.632903861236;5678.801241956532;5688.573356998241;5693.430656934315;5526.944730552683;5649.661020338793;5665.66006039639;5668.489835914787;5669.092945128759;4908.901821963576;4924.704517728947;4941.925871111936;4942;4947.282644016597;20009.899950500156;20098.39704808858;20346.28787992428;20367;20399.592008159903;2044.5501989562422;2123.065851025544;2151.741790985076;2212.6791615215866;2310.260716570698;11988;12618.81071783924;13108.934455327662;13127.277999710011;13359.756824412918;1828.076821205296;1856.8700190986635;1862.3202531076195;1932.0726051495221;1945.9610807783765;57843;58073.70963145157;58592.70703646497;60702.392976070114;61193.38806611966;9790.510474476248;9845.015498450097;9863.654772083086;9889.406635601887;9965.10314071737;13052.869471305165;13053.086283960221;13059.673508162372;13076.476940922446;13077.869221307856;6996.545224560489;7017.754378596725;7058.858822823515;7064.293570642997;7068.363847253772;6611.305812889674;6635.966820165965;6636.203655561363;6667.566608170453;6681.832954176088;4163.875083747493;4247.5540068292385;4274.508431530352;4306.5262821089655;4386.605205531454;1668.5328108129743;1701.4640388277653;1704.8806583539033;1706.5648259693698;1707.240278076244;424.7048301430476;432.54150600363715;993.0169132558715;998.4558415663481;1046.8796088449926;9633.518324083769;10175.338602990782;10432.895671043345;10593.152547796159;10710.839337409945;421.78488970625205;423.14524660186254;438.2177812604486;919.632147141149;946.6686659669199;8676.696315628922;8828.161324674145;9048.914130304274;9066.365354425126;9096.135867092615;462432;462838;495610;548841;560083;73015;76769.61615192;81070.59464702639;82958.75561866577;83023;1154.105568184647;1155.399192419937;1186.4245840767394;1189.9643010709692;1217.5860207529483;14858.628534286298;14922.77615835785;15243.390264389744;15695.058296502246;16160.515184544482;34057.318853623285;34679.306413871076;35281.60468983279;35626.28747425089;35775.64224357723;48790.268145978545;48964.510354895996;50045;50718.74640626773;50799.746001269756;9338.159565639126;9423.340366174301;9511.286653500876;9539.809203816023;9556.187724043533;9114.766882113925;13373.465061397435;14704.779428308799;17495.21271542809;17789.288428462718;13653.453861845415;13880.167189968633;14187.574372768833;14293.35679894428;14448.855511444752;13885.166889986633;14029.158250504594;14162.504312349018;14456.638584035063;14600.85399145995;11431.371274579646;14539.491117811249;14562.271886405426;14953.327100280296;15064.774028389364;9282.72151835446;9370.67202647904;9455.101765332283;9480;9530.904690953003;14099.859001409855;14161.787573186204;14315.212663303619;14342.426302948183;14462.493812716504 14:11:58 INFO - PROCESS | 16271 | |3;mootools.html;1295.3393769177717;1436.2675035731775;1438.532476944993;1577.337518242338;1752.9123543822805;6527.80416587502;7104.076470058892;7229.421646268299;7235.963820180892;7236.891446628291;6922.7923162305215;7043.506954513186;7050.153981522225;7087.6810543525535;7096.751613693522;1879.3891985104826;1911.0731295321757;2139.60417322795;2151.032035583986;2171.7936796004356;2152.7954844289766;2152.870827750332;2154.4183070570934;2155.644318687415;2157;2089.3940757180476;2094.968575471369;2100.663893776996;2105.210546045233;2105.957880842382;2157.266529380003;2158.589867925097;2160.503084290622;2169.5986242545177;2187.267265466071;2135.6689713094497;2150.559135377244;2166.815820655246;2167.41479800453;2168.913243470259;7124.857502849965;7142.678579463936;7186.820329491752;7198.820029499252;7198.892016619702;4324.308110702273;4412.911741765179;4434.423524941769;4442.822287108512;4444.066745983348;2908.650961884566;2913.7960342776014;2957.3641667041475;2967.243352945007;3048.4512787698204;969.3699095587854;991.5339790298548;1000.8448690452991;1022;1050.616524968381;10124.139448146916;10137.543810528545;10144.847827282596;10151.543180556819;10157.746056348577;3964.0684439156776;3982.0443093657314;4047.5952404759287;4053.2096241233266;4067.593240675909;8643.35174861888;8736.257418119403;8740.213380795632;8742.08208138149;8746.956265218632;4388.956110438919;4451;4459.397981272552;4460.130274596422;4462.553744625511;4048.2915489789757;4054.2296963577414;4055.8986025349604;4059.3505039193587;4061.5532291447917;3245.837708114585;3302.455094909361;3360.9495857562156;3465.1856813648774;3532.5584301962253;1127.0870594818223;1138.3795831271977;1140.2303445174473;1147.8048731715628;1158.461315488302;1067.018343124312;1067.5836423794726;1096.1285777806663;1141.9371934543515;1302.4659889445472;6694.364035416725;6752.561083529555;6760.019797129388;6764.323567643196;6766.15423072116;986.8766404199475;989.302541708094;989.5992123190119;1011.0395124631482;1017.6336518853207;5343.973280133574;5420.457954204627;5429.53848922846;5438.864028399243;5439.755211015514;8751.56242187888;8773.473591584525;8853.29173666105;8870;8878.978917424449;8719.782005449788;8782.692605758768;8829.911700883038;8839.955800220958;8843.336749743796;6778.559393639398;6792.524523283421;6842;6921.065656136358;6940.757073502403;6630.966845165936;6664.033715111379;6687.164104486939;6700.095487109178;6708.865822683617;7782;7960.84078318442;7995.12053674107;8013.398995075509;8127.431079824356;8149.674013039412;8213.95893020531;8306.667733290842;8390.622421990904;8402.789930251793;6395.776147834804;6425.45383642377;6457.7094030767785;6478.546501744832;6486.189226346707;6428.228612566522;6464.450521705708;6566.409023187936;6586.868262634816;6644.933550664431;6462.870742585216;6579.111819904443;6627.536072474881;6635.701393437404;6813.557118787461;6363.3000369958345;6404.647744374104;6408.166938297992;6474.5791523550815;6537.5750576212395;6501.707423165874;6524.151860258136;6565.982272747732;6566.868662626816;6571.80284591463;6065.8180254592435;6085.695715214133;6098.725557350019;6118.694065296806;6119.357467465852;6015.879682406415;6118.143459915526;6120.020796672511;6136.386361363828;6136.969315153396 14:11:58 INFO - PROCESS | 16271 | |4;prototype.html;303.65686773945447;310.4319096054221;315.728473512779;316.50941041385863;318.39187152538653;5966.105084237367;6102.908456373152;6123.173371594833;6124.265088189412;6133.50931925446;5977.40225977402;5979;6000.909986350197;6004.039353703409;6004.07869481766;4441.244988351972;4512.909741805179;4628.282616194495;4628.768561571908;4629.513901040401;4566.794494247767;4653.581177694007;4659.044895796354;4670.182718024349;4676.064787042588;4608.055348653518;4611.861644150681;4617.746023968681;4624.375709279255;4626.560476754703;4355.978220108895;4416.911661766747;4434.046679963791;4440.111977604492;4608.078384323132;3958.9010274743073;3985;4015.0765323975356;4024.6981476389387;4031.9516925599555;5576.9163462548095;5645.8588535286535;5647.830565083054;5648.039833228361;5651.830445086613;5381.623286369956;5383.650062745909;5385.380681221632;5385.78456861729;5394.298741163623;6217.906731398987;6410.134631824691;6423.132877061584;6428.485721142298;6428.61428314298;4484.8430304939175;4488.932666010012;4490.236659767847;4490.550944905516;4497.820087196508;6607.768728094494;6700.564463309918;6703.664816759143;6708.496862735315;6714.093597364391;4409.074094440203;4516.570925762047;4518.502964673883;4623;4628.861134165981;4567.3377360282575;4571.337156112345;4572.8399506017795;4623.237165867661;4635.791389387486;5347.876945841417;5349.384820745586;5351.973240133852;5357.919631205457;5358.115910874662;6428.742850286029;6448.097266382711;6453.064305675744;6454.483641308778;6460.483161347081;1591.8089829220567;1661.3437692111547;1663.3097264635282;1665.0342801175289;1667.5080851148941;1057.376148072641;1090.5583238788304;1090.8800031996475;1094.3980810554162;1112.3881864974394;6122.357152498924;6122.448979591858;6136.2636483622255;6141.969290153521;6146.815595532141;6540.215174179034;6545.05096760967;6563.081168636395;6572.671366431659;6582.341765823475;5995.880082398327;6074.088886667036;6074.271087469532;6077.939220607737;6096.116063170815;3531.4879342495196;3565.4830049642655;3569.37535931211;3572.1783989682;3573.6426357364057;6807.863842723118;6834.1457317835275;6836.760713375107;6840.281770414134;6846.281140480278;6668.733250670016;6760.966195168992;6767.086443330186;6769.763058292936;6770.5599136056;6786;6829.795106146824;6840.247572766992;6851.691673874688;6857.108575885203;6558.409743123142;6562.507811914221;6571.178602674666;6573.244076931022;6574.0796288520605;6402.487800975818;6542.149520562297;6547.770828020996;6551.44312733423;6561.967190164019;6823.044773731583;6832.658367081725;6834.863302733818;6835.760748373982;6838.829029274308;4607.838725644587;4609.861704148881;4612.884677883079;4617.699849509771;4621.60716339115;6615.702293396713;6621.1392518972225;6629.071929929717;6629.569078009914;6634.303398143125;6274.623522588659;6406.5515413920575;6433.0057682118695;6434.227892652912;6439.7424103035355;6409.679516024087;6418.839529011812;6422.550421470452;6424.646644434414;6425;6201.875962480815;6299.748010079546;6308.053791931064;6310.52671049664;6311.96844015777;6369.8726025480155;6436.16329877113;6438.90341644885;6450.774222902176;6459.418652321314;6263.74945002213;6285.465735412358;6286.717097730704;6294.779682711083;6295.779647712491 14:11:58 INFO - PROCESS | 16271 | |5;yui.html;780.5706861226325;835.5237514616667;835.586384739554;850.4897061762942;851.8679604661276;12884.742305153903;13029;13049.478020879153;13049.67375815605;13129.671758206037;11691.29852208868;12746.235225886454;12830.166039207468;12833.743325133491;12835.294058826761;675.2875716119491;823.2261674026425;835.7868743470407;836.7029704454923;841.1798496465958;815.042325267808;816.1185919207242;821.109096630157;824.2581676491146;824.2746383182791;706.071515956518;715.0418439291349;872.1714371347246;880.4321212817729;880.7798050487378;853.9146085391474;870.6778491957984;872.0930232558195;873.7859224489977;876.772039269788;640.7693230437039;642.9324920883333;643.1510406263734;643.2602507116807;643.5302229372584;12940.352982350845;13049.673758156123;13074.803877941838;13086.214827110403;13114.278714670689;11949.880501194964;12449.128561000734;12539.31033793141;12746.617601471971;13177.670558236025;10319.226058045602;10335.121514671187;10516.158707303397;10604.204684648683;10838.458077096113;3654.5979942206336;3665.5601327840563;3693.6675699186935;3731.2910546996254;3838.2899163654815;47037;47448.76275618634;47561.524384756056;47621.76189119067;48513.514864851255;9612.51937403127;9764.853527196956;9811.362261452983;9862.457564834003;9887.604495820087;16411.753823692656;16414.917925410296;16476.258568364454;16478.2584783685;16491.505254842374;7338.596377199198;7427.294407031323;7542.132654744774;7637.579933103732;7735.071791385069;4319.265724826724;4411.316245981878;4421.425214722066;4424.535423780521;4442.955570444319;2973.405318936178;2992.7755418343713;3002.3695024045196;3004.038707613586;3006.353633968707;523.3118449239238;545.2638937434511;550.8154768152714;555.4556534596119;557.3256359804682;568.46848196936;633.9568730746897;637.7773459493661;646.1714342520547;671.6641679160322;8448.57757112142;8934.86597701035;9242.907570924339;9263.814723705487;9384.202342800801;494.7377889718455;577.7313549199642;626.949844012487;627.2347735762363;647.2297965421134;3866.4007078902814;4077.959220407817;4089.44792453021;4283.400323954649;4485;54710.72644636831;55842.72078639581;55929;55942.44057559453;55978.72010639921;49950.25074623884;50685.493145068074;50840;51042.23436648453;51186.74406627943;43887.56112438835;44186.55813441889;44559;44687.55312446899;44777.10445791066;8420.578971051546;8442.409031367992;8764.34267429958;8837.646494140163;8841;32737.67262327346;32895.177620559676;33867.49198761971;33931;34144.65855341415;40279.59720402758;43851.56148438475;44151.55848441603;44162.55837441584;44356.556434435246;10267.897321026694;10406.194945704621;10455.94772026135;10515.106215971728;10671.733206669895;12346.320952347707;12425.37873106359;12451.626451206479;12519.874801251872;12578.245305281713;11200.215984881306;11301.547938082385;11337.773244534897;11522.193446458667;11737.295762254293;11139.72150696239;11202.103831693283;11539.88460115388;11694.181407301407;11816;7799.571452118053;10484.737881553023;11310.830337545109;11463.885361146282;11717.355545444741;9926.851097233692;10111.443870586894;10162.339447935861;10194.031567001122;10433.686989390331;8981.820363592822;9091.272698184262;9315.534223288672;9328.860067099135;9535.952320238355 14:11:58 INFO - PROCESS | 16271 | __end_tp_report 14:11:58 INFO - PROCESS | 16271 | __start_cc_report 14:11:58 INFO - PROCESS | 16271 | _x_x_mozilla_cycle_collect,1045 14:11:58 INFO - PROCESS | 16271 | __end_cc_report 14:11:58 INFO - PROCESS | 16271 | __startTimestamp1451167918785__endTimestamp 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | ------- Summary: start ------- 14:11:58 INFO - PROCESS | 16271 | Number of tests: 6 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | [#0] dojo.html Cycles:165 Average:5251.90 Median:5498.92 stddev:695.19 (12.6%) stddev-sans-first:677.36 14:11:58 INFO - PROCESS | 16271 | Values: 3143.5 3190.7 3225.7 3233.1 3252.6 5132.3 5250.4 5262.8 5286.2 5291.0 5147.2 5175.9 5284.4 5344.3 5428.4 4860.9 4881.6 4903.1 4966.8 4991.0 312.7 4722.9 4881.2 4885.0 4954.8 4803.4 4804.3 4862.3 4874.8 4919.7 4874.7 4877.2 4883.6 4888.9 4928.6 4739.3 4808.6 4838.2 4863.2 4902.8 5145.4 5158.7 5168.2 5173.2 5179.5 5690.3 5713.3 5715.1 5717.7 5752.0 5570.5 5695.1 5700.1 5748.8 5773.7 5222.5 5251.1 5286.8 5293.3 5296.2 5847.2 5852.9 5857.5 5860.2 5860.3 5535.1 5571.9 5637.7 5638.4 5642.6 5592.9 5721.0 5773.0 5795.6 5840.6 5605.4 5675.5 5682.7 5687.3 5691.6 5562.3 5666.9 5689.2 5701.6 5707.9 4341.7 4343.2 4361.8 4364.5 4376.1 3910.6 3933.3 3936.4 3943.8 3962.6 5192.0 5321.1 5345.8 5355.7 5356.5 5593.5 5601.0 5627.0 5639.5 5654.4 5352.3 5359.6 5373.5 5377.4 5378.0 4699.0 4811.5 4816.5 4817.9 4870.3 5817.7 5875.9 5898.8 5904.4 5959.5 5694.2 5707.7 5707.7 5714.0 5714.2 5739.1 5845.2 5853.0 5875.2 5885.8 5524.2 5567.7 5583.3 5613.8 5626.9 5631.4 5666.7 5677.7 5688.5 5700.1 5481.5 5489.0 5546.6 5547.2 5600.9 5523.3 5569.1 5576.3 5577.5 5628.6 5483.9 5498.9 5499.5 5500.3 5504.6 5377.7 5455.1 5486.0 5589.8 5630.1 5483.6 5525.6 5543.2 5543.5 5585.2 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | [#1] ext.html Cycles:180 Average:43446.81 Median:31688.37 stddev:75259.94 (237.5%) stddev-sans-first:75402.19 14:11:58 INFO - PROCESS | 16271 | Values: 563.4 578.0 578.4 578.9 582.7 27559.3 28133.4 28160.4 28171.6 28235.7 28853.4 29266.6 36161.1 36533.5 36652.0 8640.2 8793.3 8797.6 8805.2 8822.9 8645.7 8761.2 8776.3 8777.5 8779.6 7567.5 7726.4 7728.3 7728.3 10182.8 9894.6 9992.8 9996.2 10000.8 10011.3 9875.0 10000.7 10004.1 10010.5 10016.5 30570.8 31336.2 39433.6 39940.8 40715.6 3240.6 3254.8 3320.7 3434.1 3675.8 26408.7 26560.2 27038.0 27096.6 27473.0 3892.7 3913.9 3935.2 3967.4 4024.9 221181.0 222162.0 272514.0 276630.0 442769.0 49095.5 49349.8 49405.0 49830.8 49852.8 51824.2 51888.5 51987.0 51988.0 52176.2 14375.7 14417.2 14459.8 14501.9 14577.3 10435.2 10435.6 10458.4 10463.9 10468.6 18375.7 18377.4 18411.2 18427.6 18454.3 7544.2 7642.3 7823.4 7830.6 7865.8 987.9 999.9 1006.2 1037.8 1082.0 28175.2 28616.4 28730.4 29046.9 29164.0 1041.8 1051.9 1068.1 1071.8 1104.5 14996.4 15104.8 15220.6 15226.4 15367.8 309483.0 314373.0 314760.0 314941.0 315102.0 42706.6 42753.8 42775.8 42798.6 42812.1 1322.8 1326.5 1333.2 1340.9 1349.0 27672.7 28283.0 28430.6 28482.3 28648.6 41102.6 42529.4 44883.8 46223.5 46282.5 243600.0 243723.0 244926.0 245582.0 246702.0 26506.9 26980.2 29317.3 30654.4 31304.4 36637.8 37304.4 37362.8 38038.6 38252.8 31652.5 31898.7 32047.2 33380.3 35511.6 33976.2 34441.5 35296.8 35480.6 35660.8 34060.5 34259.8 34862.0 34889.0 34904.7 29646.0 29706.9 31724.2 31960.5 32030.7 24623.0 24677.3 24680.9 24962.6 25203.4 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | [#2] jquery.html Cycles:180 Average:27624.38 Median:4030.94 stddev:83067.59 (2060.8%) stddev-sans-first:83275.30 14:11:58 INFO - PROCESS | 16271 | Values: 315.2 315.5 319.0 322.2 328.6 13726.5 14105.4 15698.6 16143.3 16363.0 15442.2 15766.0 16459.9 16521.2 16537.9 4481.0 5248.2 5268.5 5272.7 5274.8 3801.2 3898.0 5225.0 5591.0 5737.9 5628.1 5647.6 5678.8 5688.6 5693.4 5526.9 5649.7 5665.7 5668.5 5669.1 4908.9 4924.7 4941.9 4942.0 4947.3 20009.9 20098.4 20346.3 20367.0 20399.6 2044.6 2123.1 2151.7 2212.7 2310.3 11988.0 12618.8 13108.9 13127.3 13359.8 1828.1 1856.9 1862.3 1932.1 1946.0 57843.0 58073.7 58592.7 60702.4 61193.4 9790.5 9845.0 9863.7 9889.4 9965.1 13052.9 13053.1 13059.7 13076.5 13077.9 6996.5 7017.8 7058.9 7064.3 7068.4 6611.3 6636.0 6636.2 6667.6 6681.8 4163.9 4247.6 4274.5 4306.5 4386.6 1668.5 1701.5 1704.9 1706.6 1707.2 424.7 432.5 993.0 998.5 1046.9 9633.5 10175.3 10432.9 10593.2 10710.8 421.8 423.1 438.2 919.6 946.7 8676.7 8828.2 9048.9 9066.4 9096.1 462432.0 462838.0 495610.0 548841.0 560083.0 73015.0 76769.6 81070.6 82958.8 83023.0 1154.1 1155.4 1186.4 1190.0 1217.6 14858.6 14922.8 15243.4 15695.1 16160.5 34057.3 34679.3 35281.6 35626.3 35775.6 48790.3 48964.5 50045.0 50718.7 50799.7 9338.2 9423.3 9511.3 9539.8 9556.2 9114.8 13373.5 14704.8 17495.2 17789.3 13653.5 13880.2 14187.6 14293.4 14448.9 13885.2 14029.2 14162.5 14456.6 14600.9 11431.4 14539.5 14562.3 14953.3 15064.8 9282.7 9370.7 9455.1 9480.0 9530.9 14099.9 14161.8 14315.2 14342.4 14462.5 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | [#3] mootools.html Cycles:180 Average:5117.22 Median:6119.03 stddev:2642.86 (43.2%) stddev-sans-first:2634.66 14:11:58 INFO - PROCESS | 16271 | Values: 1295.3 1436.3 1438.5 1577.3 1752.9 6527.8 7104.1 7229.4 7236.0 7236.9 6922.8 7043.5 7050.2 7087.7 7096.8 1879.4 1911.1 2139.6 2151.0 2171.8 2152.8 2152.9 2154.4 2155.6 2157.0 2089.4 2095.0 2100.7 2105.2 2106.0 2157.3 2158.6 2160.5 2169.6 2187.3 2135.7 2150.6 2166.8 2167.4 2168.9 7124.9 7142.7 7186.8 7198.8 7198.9 4324.3 4412.9 4434.4 4442.8 4444.1 2908.7 2913.8 2957.4 2967.2 3048.5 969.4 991.5 1000.8 1022.0 1050.6 10124.1 10137.5 10144.8 10151.5 10157.7 3964.1 3982.0 4047.6 4053.2 4067.6 8643.4 8736.3 8740.2 8742.1 8747.0 4389.0 4451.0 4459.4 4460.1 4462.6 4048.3 4054.2 4055.9 4059.4 4061.6 3245.8 3302.5 3360.9 3465.2 3532.6 1127.1 1138.4 1140.2 1147.8 1158.5 1067.0 1067.6 1096.1 1141.9 1302.5 6694.4 6752.6 6760.0 6764.3 6766.2 986.9 989.3 989.6 1011.0 1017.6 5344.0 5420.5 5429.5 5438.9 5439.8 8751.6 8773.5 8853.3 8870.0 8879.0 8719.8 8782.7 8829.9 8840.0 8843.3 6778.6 6792.5 6842.0 6921.1 6940.8 6631.0 6664.0 6687.2 6700.1 6708.9 7782.0 7960.8 7995.1 8013.4 8127.4 8149.7 8214.0 8306.7 8390.6 8402.8 6395.8 6425.5 6457.7 6478.5 6486.2 6428.2 6464.5 6566.4 6586.9 6644.9 6462.9 6579.1 6627.5 6635.7 6813.6 6363.3 6404.6 6408.2 6474.6 6537.6 6501.7 6524.2 6566.0 6566.9 6571.8 6065.8 6085.7 6098.7 6118.7 6119.4 6015.9 6118.1 6120.0 6136.4 6137.0 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | [#4] prototype.html Cycles:180 Average:5351.43 Median:6099.51 stddev:1612.89 (26.4%) stddev-sans-first:1572.29 14:11:58 INFO - PROCESS | 16271 | Values: 303.7 310.4 315.7 316.5 318.4 5966.1 6102.9 6123.2 6124.3 6133.5 5977.4 5979.0 6000.9 6004.0 6004.1 4441.2 4512.9 4628.3 4628.8 4629.5 4566.8 4653.6 4659.0 4670.2 4676.1 4608.1 4611.9 4617.7 4624.4 4626.6 4356.0 4416.9 4434.0 4440.1 4608.1 3958.9 3985.0 4015.1 4024.7 4032.0 5576.9 5645.9 5647.8 5648.0 5651.8 5381.6 5383.7 5385.4 5385.8 5394.3 6217.9 6410.1 6423.1 6428.5 6428.6 4484.8 4488.9 4490.2 4490.6 4497.8 6607.8 6700.6 6703.7 6708.5 6714.1 4409.1 4516.6 4518.5 4623.0 4628.9 4567.3 4571.3 4572.8 4623.2 4635.8 5347.9 5349.4 5352.0 5357.9 5358.1 6428.7 6448.1 6453.1 6454.5 6460.5 1591.8 1661.3 1663.3 1665.0 1667.5 1057.4 1090.6 1090.9 1094.4 1112.4 6122.4 6122.4 6136.3 6142.0 6146.8 6540.2 6545.1 6563.1 6572.7 6582.3 5995.9 6074.1 6074.3 6077.9 6096.1 3531.5 3565.5 3569.4 3572.2 3573.6 6807.9 6834.1 6836.8 6840.3 6846.3 6668.7 6761.0 6767.1 6769.8 6770.6 6786.0 6829.8 6840.2 6851.7 6857.1 6558.4 6562.5 6571.2 6573.2 6574.1 6402.5 6542.1 6547.8 6551.4 6562.0 6823.0 6832.7 6834.9 6835.8 6838.8 4607.8 4609.9 4612.9 4617.7 4621.6 6615.7 6621.1 6629.1 6629.6 6634.3 6274.6 6406.6 6433.0 6434.2 6439.7 6409.7 6418.8 6422.6 6424.6 6425.0 6201.9 6299.7 6308.1 6310.5 6312.0 6369.9 6436.2 6438.9 6450.8 6459.4 6263.7 6285.5 6286.7 6294.8 6295.8 14:11:58 INFO - PROCESS | 16271 | 14:11:58 INFO - PROCESS | 16271 | [#5] yui.html Cycles:180 Average:13506.54 Median:44732.33 stddev:15498.42 (34.6%) stddev-sans-first:15512.43 14:11:58 INFO - PROCESS | 16271 | Values: 780.6 835.5 835.6 850.5 851.9 12884.7 13029.0 13049.5 13049.7 13129.7 11691.3 12746.2 12830.2 12833.7 12835.3 675.3 823.2 835.8 836.7 841.2 815.0 816.1 821.1 824.3 824.3 706.1 715.0 872.2 880.4 880.8 853.9 870.7 872.1 873.8 876.8 640.8 642.9 643.2 643.3 643.5 12940.4 13049.7 13074.8 13086.2 13114.3 11949.9 12449.1 12539.3 12746.6 13177.7 10319.2 10335.1 10516.2 10604.2 10838.5 3654.6 3665.6 3693.7 3731.3 3838.3 47037.0 47448.8 47561.5 47621.8 48513.5 9612.5 9764.9 9811.4 9862.5 9887.6 16411.8 16414.9 16476.3 16478.3 16491.5 7338.6 7427.3 7542.1 7637.6 7735.1 4319.3 4411.3 4421.4 4424.5 4443.0 2973.4 2992.8 3002.4 3004.0 3006.4 523.3 545.3 550.8 555.5 557.3 568.5 634.0 637.8 646.2 671.7 8448.6 8934.9 9242.9 9263.8 9384.2 494.7 577.7 626.9 627.2 647.2 3866.4 4078.0 4089.4 4283.4 4485.0 54710.7 55842.7 55929.0 55942.4 55978.7 49950.3 50685.5 50840.0 51042.2 51186.7 43887.6 44186.6 44559.0 44687.6 44777.1 8420.6 8442.4 8764.3 8837.6 8841.0 32737.7 32895.2 33867.5 33931.0 34144.7 40279.6 43851.6 44151.6 44162.6 44356.6 10267.9 10406.2 10455.9 10515.1 10671.7 12346.3 12425.4 12451.6 12519.9 12578.2 11200.2 11301.5 11337.8 11522.2 11737.3 11139.7 11202.1 11539.9 11694.2 11816.0 7799.6 10484.7 11310.8 11463.9 11717.4 9926.9 10111.4 10162.3 10194.0 10433.7 8981.8 9091.3 9315.5 9328.9 9536.0 14:11:58 INFO - PROCESS | 16271 | -------- Summary: end -------- 14:11:58 INFO - PROCESS | 16271 | 14:11:59 INFO - TEST-INFO | 16271: exit 0 14:11:59 INFO - TEST-OK | dromaeo_css | took 1111814ms 14:11:59 INFO - TEST-START | kraken 14:11:59 INFO - operating with platform_type : linux_ 14:11:59 INFO - Initialising browser for kraken test... 14:11:59 INFO - TEST-INFO | started process 16454 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2OHRnD/profile http://localhost:57939/getInfo.html) 14:12:03 INFO - PROCESS | 16454 | __metrics Screen width/height:1600/1200 14:12:03 INFO - PROCESS | 16454 | colorDepth:24 14:12:03 INFO - PROCESS | 16454 | Browser inner width/height: 1024/697 14:12:03 INFO - PROCESS | 16454 | __metrics 14:12:03 INFO - PROCESS | 16454 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:12:03 INFO - PROCESS | 16454 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:04 INFO - TEST-INFO | 16454: exit 0 14:12:04 INFO - Browser initialized. 14:12:04 INFO - Running cycle 1/1 for kraken test... 14:12:04 INFO - TEST-INFO | started process 16538 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2OHRnD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:15 INFO - PROCESS | 16538 | RSS: Main: 148627456 14:12:15 INFO - PROCESS | 16538 | 14:12:18 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection) 14:12:18 INFO - PROCESS | 16538 | RSS: Main: 183812096 14:12:18 INFO - PROCESS | 16538 | 14:12:21 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-dft) 14:12:22 INFO - PROCESS | 16538 | RSS: Main: 174546944 14:12:22 INFO - PROCESS | 16538 | 14:12:24 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-fft) 14:12:25 INFO - PROCESS | 16538 | RSS: Main: 159363072 14:12:25 INFO - PROCESS | 16538 | 14:12:27 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator) 14:12:27 INFO - PROCESS | 16538 | RSS: Main: 163405824 14:12:27 INFO - PROCESS | 16538 | 14:12:30 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:30 INFO - PROCESS | 16538 | RSS: Main: 163909632 14:12:30 INFO - PROCESS | 16538 | 14:12:33 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:34 INFO - PROCESS | 16538 | RSS: Main: 165064704 14:12:34 INFO - PROCESS | 16538 | 14:12:37 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:38 INFO - PROCESS | 16538 | RSS: Main: 164274176 14:12:38 INFO - PROCESS | 16538 | 14:12:40 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial) 14:12:41 INFO - PROCESS | 16538 | RSS: Main: 165642240 14:12:41 INFO - PROCESS | 16538 | 14:12:42 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:43 INFO - PROCESS | 16538 | RSS: Main: 176783360 14:12:43 INFO - PROCESS | 16538 | 14:12:45 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:45 INFO - PROCESS | 16538 | RSS: Main: 174432256 14:12:45 INFO - PROCESS | 16538 | 14:12:47 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:48 INFO - PROCESS | 16538 | RSS: Main: 182509568 14:12:48 INFO - PROCESS | 16538 | 14:12:50 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:51 INFO - PROCESS | 16538 | RSS: Main: 191447040 14:12:51 INFO - PROCESS | 16538 | 14:12:54 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:54 INFO - PROCESS | 16538 | RSS: Main: 187969536 14:12:54 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57939/tests/kraken/driver.html?testName=ai-astar) 14:12:56 INFO - PROCESS | 16538 | RSS: Main: 245719040 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | __start_tp_report 14:12:56 INFO - PROCESS | 16538 | _x_x_mozilla_page_load 14:12:56 INFO - PROCESS | 16538 | _x_x_mozilla_page_load_details 14:12:56 INFO - PROCESS | 16538 | |i|pagename|runs| 14:12:56 INFO - PROCESS | 16538 | |0;ai-astar;111;111;106;109;111;111;100;111;113;102 14:12:56 INFO - PROCESS | 16538 | |1;audio-beat-detection;148;122;147;165;138;160;156;123;166;123 14:12:56 INFO - PROCESS | 16538 | |2;audio-dft;162;161;161;160;163;162;162;162;159;161 14:12:56 INFO - PROCESS | 16538 | |3;audio-fft;71;72;84;96;72;75;74;111;88;73 14:12:56 INFO - PROCESS | 16538 | |4;audio-oscillator;95;97;140;95;96;96;148;95;96;143 14:12:56 INFO - PROCESS | 16538 | |5;imaging-gaussian-blur;109;109;108;109;109;109;109;108;109;109 14:12:56 INFO - PROCESS | 16538 | |6;imaging-darkroom;146;146;146;148;145;146;145;145;146;146 14:12:56 INFO - PROCESS | 16538 | |7;imaging-desaturate;96;95;95;95;95;95;95;96;95;95 14:12:56 INFO - PROCESS | 16538 | |8;json-parse-financial;58;57;58;57;57;56;57;64;54;55 14:12:56 INFO - PROCESS | 16538 | |9;json-stringify-tinderbox;67;66;67;68;67;67;67;67;67;68 14:12:56 INFO - PROCESS | 16538 | |10;stanford-crypto-aes;84;86;89;88;86;86;86;86;86;85 14:12:56 INFO - PROCESS | 16538 | |11;stanford-crypto-ccm;130;115;120;115;120;135;120;125;118;121 14:12:56 INFO - PROCESS | 16538 | |12;stanford-crypto-pbkdf2;138;152;150;148;147;149;148;159;148;140 14:12:56 INFO - PROCESS | 16538 | |13;stanford-crypto-sha256-iterative;68;68;66;66;67;67;67;67;65;66 14:12:56 INFO - PROCESS | 16538 | __end_tp_report 14:12:56 INFO - PROCESS | 16538 | __start_cc_report 14:12:56 INFO - PROCESS | 16538 | _x_x_mozilla_cycle_collect,909 14:12:56 INFO - PROCESS | 16538 | __end_cc_report 14:12:56 INFO - PROCESS | 16538 | __startTimestamp1451167976656__endTimestamp 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | ------- Summary: start ------- 14:12:56 INFO - PROCESS | 16538 | Number of tests: 14 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#0] ai-astar Cycles:10 Average:108.50 Median:111.00 stddev:4.38 (3.9%) stddev-sans-first:4.55 14:12:56 INFO - PROCESS | 16538 | Values: 111.0 111.0 106.0 109.0 111.0 111.0 100.0 111.0 113.0 102.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:152.00 stddev:17.47 (11.5%) stddev-sans-first:18.49 14:12:56 INFO - PROCESS | 16538 | Values: 148.0 122.0 147.0 165.0 138.0 160.0 156.0 123.0 166.0 123.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 14:12:56 INFO - PROCESS | 16538 | Values: 162.0 161.0 161.0 160.0 163.0 162.0 162.0 162.0 159.0 161.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:13.29 (17.8%) stddev-sans-first:13.53 14:12:56 INFO - PROCESS | 16538 | Values: 71.0 72.0 84.0 96.0 72.0 75.0 74.0 111.0 88.0 73.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:95.50 stddev:23.25 (24.3%) stddev-sans-first:24.01 14:12:56 INFO - PROCESS | 16538 | Values: 95.0 97.0 140.0 95.0 96.0 96.0 148.0 95.0 96.0 143.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:12:56 INFO - PROCESS | 16538 | Values: 109.0 109.0 108.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 14:12:56 INFO - PROCESS | 16538 | Values: 146.0 146.0 146.0 148.0 145.0 146.0 145.0 145.0 146.0 146.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:12:56 INFO - PROCESS | 16538 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.67 (4.7%) stddev-sans-first:2.82 14:12:56 INFO - PROCESS | 16538 | Values: 58.0 57.0 58.0 57.0 57.0 56.0 57.0 64.0 54.0 55.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 14:12:56 INFO - PROCESS | 16538 | Values: 67.0 66.0 67.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.24 14:12:56 INFO - PROCESS | 16538 | Values: 84.0 86.0 89.0 88.0 86.0 86.0 86.0 86.0 86.0 85.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:120.50 stddev:6.40 (5.3%) stddev-sans-first:6.08 14:12:56 INFO - PROCESS | 16538 | Values: 130.0 115.0 120.0 115.0 120.0 135.0 120.0 125.0 118.0 121.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:148.50 stddev:5.84 (3.9%) stddev-sans-first:4.97 14:12:56 INFO - PROCESS | 16538 | Values: 138.0 152.0 150.0 148.0 147.0 149.0 148.0 159.0 148.0 140.0 14:12:56 INFO - PROCESS | 16538 | 14:12:56 INFO - PROCESS | 16538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.88 14:12:56 INFO - PROCESS | 16538 | Values: 68.0 68.0 66.0 66.0 67.0 67.0 67.0 67.0 65.0 66.0 14:12:56 INFO - PROCESS | 16538 | -------- Summary: end -------- 14:12:56 INFO - PROCESS | 16538 | 14:12:57 INFO - TEST-INFO | 16538: exit 0 14:12:57 INFO - TEST-OK | kraken | took 58061ms 14:12:57 INFO - TEST-START | v8_7 14:12:57 INFO - operating with platform_type : linux_ 14:12:57 INFO - Initialising browser for v8_7 test... 14:12:57 INFO - TEST-INFO | started process 16785 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_NH5kl/profile http://localhost:57939/getInfo.html) 14:13:00 INFO - PROCESS | 16785 | __metrics Screen width/height:1600/1200 14:13:00 INFO - PROCESS | 16785 | colorDepth:24 14:13:00 INFO - PROCESS | 16785 | Browser inner width/height: 1024/697 14:13:00 INFO - PROCESS | 16785 | __metrics 14:13:00 INFO - PROCESS | 16785 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:13:00 INFO - PROCESS | 16785 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:13:01 INFO - TEST-INFO | 16785: exit 0 14:13:01 INFO - Browser initialized. 14:13:01 INFO - Running cycle 1/1 for v8_7 test... 14:13:01 INFO - TEST-INFO | started process 16869 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_NH5kl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:13 INFO - PROCESS | 16869 | RSS: Main: 150724608 14:13:13 INFO - PROCESS | 16869 | 14:13:34 INFO - PROCESS | 16869 | Cycle 1(1): loaded http://localhost:57939/tests/v8_7/run.html (next: http://localhost:57939/tests/v8_7/run.html) 14:13:35 INFO - PROCESS | 16869 | RSS: Main: 596389888 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | __start_tp_report 14:13:35 INFO - PROCESS | 16869 | _x_x_mozilla_page_load 14:13:35 INFO - PROCESS | 16869 | _x_x_mozilla_page_load_details 14:13:35 INFO - PROCESS | 16869 | |i|pagename|runs| 14:13:35 INFO - PROCESS | 16869 | |0;Richards;167.9261125104954 14:13:35 INFO - PROCESS | 16869 | |1;DeltaBlue;191.0949742021785 14:13:35 INFO - PROCESS | 16869 | |2;Encrypt;281.45229383619477 14:13:35 INFO - PROCESS | 16869 | |3;Decrypt;5278.9473684210525 14:13:35 INFO - PROCESS | 16869 | |4;RayTrace;1974.3589743589744 14:13:35 INFO - PROCESS | 16869 | |5;Earley;807.1025020177563 14:13:35 INFO - PROCESS | 16869 | |6;Boyer;12358.024691358025 14:13:35 INFO - PROCESS | 16869 | |7;RegExp;26473.684210526317 14:13:35 INFO - PROCESS | 16869 | |8;Splay;573.0659025787966 14:13:35 INFO - PROCESS | 16869 | |9;NavierStokes;4822.115384615385 14:13:35 INFO - PROCESS | 16869 | __end_tp_report 14:13:35 INFO - PROCESS | 16869 | __startTimestamp1451168015216__endTimestamp 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | ------- Summary: start ------- 14:13:35 INFO - PROCESS | 16869 | Number of tests: 10 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#0] Richards Cycles:1 Average:167.93 Median:167.93 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 167.9 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 191.1 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 281.5 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#3] Decrypt Cycles:1 Average:5278.95 Median:5278.95 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 5278.9 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 1974.4 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#5] Earley Cycles:1 Average:807.10 Median:807.10 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 807.1 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 12358.0 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#7] RegExp Cycles:1 Average:26473.68 Median:26473.68 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 26473.7 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#8] Splay Cycles:1 Average:573.07 Median:573.07 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 573.1 14:13:35 INFO - PROCESS | 16869 | 14:13:35 INFO - PROCESS | 16869 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:13:35 INFO - PROCESS | 16869 | Values: 4822.1 14:13:35 INFO - PROCESS | 16869 | -------- Summary: end -------- 14:13:35 INFO - PROCESS | 16869 | 14:13:36 INFO - TEST-INFO | 16869: exit 0 14:13:36 INFO - TEST-OK | v8_7 | took 38530ms 14:13:36 INFO - SUITE-END | took 1208s 14:13:36 INFO - Completed test suite (00:20:08) 14:13:36 INFO - Working with test: dromaeo_css 14:13:36 INFO - Generating results file: dromaeo_css 14:13:36 INFO - Working with test: kraken 14:13:36 INFO - Generating results file: kraken 14:13:36 INFO - javascript benchmark 14:13:36 INFO - Working with test: v8_7 14:13:36 INFO - Generating results file: v8_7 14:13:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:13:36 INFO - process_Request line: dromaeo_css 6792.78 graph.html#tests=[[72,64,35]] 14:13:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:36 INFO - process_Request line: kraken 1503.30 graph.html#tests=[[232,64,35]] 14:13:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:36 INFO - process_Request line: v8_7 19757.67 graph.html#tests=[[230,64,35]] 14:13:36 INFO - RETURN: dromaeo_css: 6792.78 14:13:36 INFO - RETURN: kraken: 1503.30 14:13:36 INFO - RETURN: v8_7: 19757.67 14:13:36 INFO - javascript benchmark 14:13:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3143.5284707293904, 3190.7447404207664, 3225.7096861282494, 3233.062411900549, 3252.5771649685544, 5132.332796736419, 5250.3699556053325, 5262.763175657095, 5286.233496143057, 5291.021161085202, 5147.150720131174, 5175.896482070356, 5284.39229488608, 5344.331958505187, 5428.4300148484335, 4860.927086093702, 4881.585065269456, 4903.141950158726, 4966.801327946878, 4991.0, 312.6816187391453, 4722.881927951795, 4881.194602890537, 4884.951150488485, 4954.822210789715, 4803.447603525587, 4804.327394164819, 4862.343583616202, 4874.780634871404, 4919.680220785637, 4874.707517548958, 4877.244027175793, 4883.609311255091, 4888.902221955576, 4928.6303527235605, 4739.336492890998, 4808.591269742076, 4838.225883858601, 4863.1732605457155, 4902.754862256908, 5145.382554093533, 5158.716270605115, 5168.224766285088, 5173.198154286091, 5179.482051794828, 5690.317161940594, 5713.257276554063, 5715.114157305624, 5717.656940583537, 5751.971240143815, 5570.470805273492, 5695.088785794294, 5700.116481945305, 5748.827535173951, 5773.682447465388, 5222.477752224785, 5251.10731175701, 5286.788528458857, 5293.285406470116, 5296.232046353296, 5847.239858818326, 5852.8536786579825, 5857.531397488191, 5860.238169037998, 5860.2967643883, 5535.059039963136, 5571.860703482364, 5637.689927054052, 5638.379778224392, 5642.605017648725, 5592.860178495489, 5720.971395143081, 5773.0, 5795.623284486495, 5840.649561026352, 5605.439456054362, 5675.489205971482, 5682.7442765075675, 5687.3459552152035, 5691.630044047124, 5562.3047119110115, 5666.886662266732, 5689.231953686282, 5701.600887937804, 5707.942920570824, 4341.674374421931, 4343.239933011773, 4361.80371883266, 4364.476262848479, 4376.14665140301, 3910.608939106067, 3933.3116704576582, 3936.389859571771, 3943.7907911937878, 3962.643362097425, 5192.0, 5321.095413779667, 5345.7594408251725, 5355.678659280456, 5356.491133342326, 5593.46862048113, 5601.047821870292, 5626.971865140648, 5639.492445679908, 5654.37801841797, 5352.277442545206, 5359.598030147755, 5373.516383525423, 5377.4084850666395, 5378.0, 4698.976505117453, 4811.542903424239, 4816.494268101869, 4817.9036419271415, 4870.293807397908, 5817.650940943557, 5875.853103672443, 5898.793542226002, 5904.380040095814, 5959.493443057302, 5694.231278777312, 5707.6575405475805, 5707.714614269187, 5713.971485132716, 5714.20001199824, 5739.110437882135, 5845.18167456548, 5852.970735146297, 5875.177475153568, 5885.793997210077, 5524.171374293888, 5567.66594004361, 5583.302087239095, 5613.803516876889, 5626.915596266142, 5631.352394474688, 5666.688332141772, 5677.687727175045, 5688.488036076773, 5700.059490184239, 5481.506664400223, 5488.9725551371985, 5546.55627549787, 5547.2233887256625, 5600.887982240414, 5523.254360661259, 5569.10894256917, 5576.275084239185, 5577.498025177591, 5628.60599758013, 5483.862903427446, 5498.917516237339, 5499.5325397340075, 5500.257465242141, 5504.6421982571, 5377.704226267593, 5455.072637651688, 5486.0125177468435, 5589.776408943597, 5630.127330263816, 5483.643563168382, 5525.640833345819, 5543.196236545759, 5543.501084902378, 5585.162225666182], "unit": "score", "name": "dojo.html", "value": 5209.745482301047}, {"lowerIsBetter": false, "replicates": [563.399979022341, 577.9682117483538, 578.4331355271834, 578.9478946894778, 582.702821561004, 27559.31101722458, 28133.437331253415, 28160.436791264186, 28171.577426338623, 28235.717642823565, 28853.422931541358, 29266.561001584992, 36161.0959726007, 36533.45199822005, 36652.0, 8640.2223799858, 8793.252573531257, 8797.560121993907, 8805.16350946659, 8822.911770882305, 8645.69740059098, 8761.211490965812, 8776.341774366949, 8777.473351598892, 8779.604917778683, 7567.470277080606, 7726.42051846111, 7728.304452599265, 7728.343090837286, 10182.847257291147, 9894.55474503649, 9992.750181245527, 9996.200303975664, 10000.799984000352, 10011.299209055333, 9875.0, 10000.749981250454, 10004.14964727999, 10010.54952527138, 10016.54925528353, 30570.847145764128, 31336.21659458509, 39433.60566394357, 39940.800295998626, 40715.59284407148, 3240.627327857303, 3254.7721659483846, 3320.701136897691, 3434.1414646338417, 3675.7794532328144, 26408.735912641012, 26560.203193904214, 27038.0, 27096.59355109675, 27473.0, 3892.727509074366, 3913.941290880639, 3935.1932853765197, 3967.444557761916, 4024.879253622396, 221181.0, 222162.0, 272514.0, 276630.0, 442768.9999999968, 49095.50904490909, 49349.75325123352, 49405.0, 49830.75084624554, 49852.75073624609, 51824.22263666048, 51888.48111518912, 51987.0, 51988.02137754206, 52176.21735673968, 14375.712485750435, 14417.207053612152, 14459.78310325346, 14501.854981450051, 14577.271136443347, 10435.16518678504, 10435.634752783617, 10458.372497650165, 10463.947680261703, 10468.581256749798, 18375.72436413455, 18377.43791777687, 18411.171497282656, 18427.63144737098, 18454.26182952667, 7544.207858174922, 7642.312191902755, 7823.374130069581, 7830.6084695764985, 7865.842683146419, 987.9259055570861, 999.8700168978132, 1006.2000709436016, 1037.838911510583, 1081.9667217807132, 28175.15474535767, 28616.427671446454, 28730.425391492052, 29046.854765726457, 29164.0, 1041.7864337810731, 1051.8632577764843, 1068.124138206663, 1071.7802850415646, 1104.5416152296707, 14996.400143994337, 15104.773428398583, 15220.619484512754, 15226.390944362323, 15367.769483457758, 309483.0, 314373.0, 314760.0, 314941.0, 315102.0, 42706.57293427088, 42753.78623106865, 42775.78612106982, 42798.57201428008, 42812.143757124686, 1322.7751282282036, 1326.5025615394227, 1333.1667707682698, 1340.8726171013739, 1349.0421800521544, 27672.723272767016, 28283.0, 28430.57354139731, 28482.287942800765, 28648.570271446362, 41102.58897411107, 42529.36205956975, 44883.77558112319, 46223.53776462192, 46282.53717462917, 243600.0, 243723.0, 244926.0, 245582.0, 246702.0, 26506.867465662548, 26980.1905942822, 29317.26706832346, 30654.386912262074, 31304.373912521165, 36637.81681091578, 37304.44043339298, 37362.8131859339, 38038.61961380351, 38252.80873595614, 31652.525212121374, 31898.6810131905, 32047.198820029687, 33380.33239335248, 35511.64488355187, 33976.15059623529, 34441.48337774885, 35296.82351588328, 35480.645193548764, 35660.821695891354, 34060.489092664124, 34259.828700856335, 34861.9541413758, 34889.0, 34904.65095349115, 29646.0, 29706.851465742533, 31724.20689482689, 31960.52059219067, 32030.679693203703, 24623.0, 24677.259682209562, 24680.876595616908, 24962.62556061624, 25203.369915752253], "unit": "score", "name": "ext.html", "value": 17545.99815716162}, {"lowerIsBetter": false, "replicates": [315.24027094701745, 315.47158509496603, 318.95853539039916, 322.23147792514845, 328.55644879412796, 13726.519571814964, 14105.435782568711, 15698.607534811636, 16143.304952979945, 16362.999999999985, 15442.227888605554, 15766.0, 16459.917700411483, 16521.173941302917, 16537.91731041346, 4480.955190448095, 5248.21276808478, 5268.473152684739, 5272.657277276984, 5274.762635681384, 3801.201747633, 3898.0, 5225.033368826779, 5591.049521581341, 5737.856553586173, 5628.127640215753, 5647.632903861236, 5678.801241956532, 5688.573356998241, 5693.430656934315, 5526.944730552683, 5649.661020338793, 5665.66006039639, 5668.489835914787, 5669.092945128759, 4908.901821963576, 4924.704517728947, 4941.925871111936, 4942.0, 4947.282644016597, 20009.899950500156, 20098.39704808858, 20346.28787992428, 20367.0, 20399.592008159903, 2044.5501989562422, 2123.065851025544, 2151.741790985076, 2212.6791615215866, 2310.260716570698, 11988.0, 12618.81071783924, 13108.934455327662, 13127.277999710011, 13359.756824412918, 1828.076821205296, 1856.8700190986635, 1862.3202531076195, 1932.0726051495221, 1945.9610807783765, 57843.0, 58073.70963145157, 58592.70703646497, 60702.392976070114, 61193.38806611966, 9790.510474476248, 9845.015498450097, 9863.654772083086, 9889.406635601887, 9965.10314071737, 13052.869471305165, 13053.086283960221, 13059.673508162372, 13076.476940922446, 13077.869221307856, 6996.545224560489, 7017.754378596725, 7058.858822823515, 7064.293570642997, 7068.363847253772, 6611.305812889674, 6635.966820165965, 6636.203655561363, 6667.566608170453, 6681.832954176088, 4163.875083747493, 4247.5540068292385, 4274.508431530352, 4306.5262821089655, 4386.605205531454, 1668.5328108129743, 1701.4640388277653, 1704.8806583539033, 1706.5648259693698, 1707.240278076244, 424.7048301430476, 432.54150600363715, 993.0169132558715, 998.4558415663481, 1046.8796088449926, 9633.518324083769, 10175.338602990782, 10432.895671043345, 10593.152547796159, 10710.839337409945, 421.78488970625205, 423.14524660186254, 438.2177812604486, 919.632147141149, 946.6686659669199, 8676.696315628922, 8828.161324674145, 9048.914130304274, 9066.365354425126, 9096.135867092615, 462432.0, 462838.0, 495610.0, 548841.0, 560083.0, 73015.0, 76769.61615192, 81070.59464702639, 82958.75561866577, 83023.0, 1154.105568184647, 1155.399192419937, 1186.4245840767394, 1189.9643010709692, 1217.5860207529483, 14858.628534286298, 14922.77615835785, 15243.390264389744, 15695.058296502246, 16160.515184544482, 34057.318853623285, 34679.306413871076, 35281.60468983279, 35626.28747425089, 35775.64224357723, 48790.268145978545, 48964.510354895996, 50045.0, 50718.74640626773, 50799.746001269756, 9338.159565639126, 9423.340366174301, 9511.286653500876, 9539.809203816023, 9556.187724043533, 9114.766882113925, 13373.465061397435, 14704.779428308799, 17495.21271542809, 17789.288428462718, 13653.453861845415, 13880.167189968633, 14187.574372768833, 14293.35679894428, 14448.855511444752, 13885.166889986633, 14029.158250504594, 14162.504312349018, 14456.638584035063, 14600.85399145995, 11431.371274579646, 14539.491117811249, 14562.271886405426, 14953.327100280296, 15064.774028389364, 9282.72151835446, 9370.67202647904, 9455.101765332283, 9480.0, 9530.904690953003, 14099.859001409855, 14161.787573186204, 14315.212663303619, 14342.426302948183, 14462.493812716504], "unit": "score", "name": "jquery.html", "value": 8473.523677746149}, {"lowerIsBetter": false, "replicates": [1295.3393769177717, 1436.2675035731775, 1438.532476944993, 1577.337518242338, 1752.9123543822805, 6527.80416587502, 7104.076470058892, 7229.421646268299, 7235.963820180892, 7236.891446628291, 6922.7923162305215, 7043.506954513186, 7050.153981522225, 7087.6810543525535, 7096.751613693522, 1879.3891985104826, 1911.0731295321757, 2139.60417322795, 2151.032035583986, 2171.7936796004356, 2152.7954844289766, 2152.870827750332, 2154.4183070570934, 2155.644318687415, 2157.0, 2089.3940757180476, 2094.968575471369, 2100.663893776996, 2105.210546045233, 2105.957880842382, 2157.266529380003, 2158.589867925097, 2160.503084290622, 2169.5986242545177, 2187.267265466071, 2135.6689713094497, 2150.559135377244, 2166.815820655246, 2167.41479800453, 2168.913243470259, 7124.857502849965, 7142.678579463936, 7186.820329491752, 7198.820029499252, 7198.892016619702, 4324.308110702273, 4412.911741765179, 4434.423524941769, 4442.822287108512, 4444.066745983348, 2908.650961884566, 2913.7960342776014, 2957.3641667041475, 2967.243352945007, 3048.4512787698204, 969.3699095587854, 991.5339790298548, 1000.8448690452991, 1022.0, 1050.616524968381, 10124.139448146916, 10137.543810528545, 10144.847827282596, 10151.543180556819, 10157.746056348577, 3964.0684439156776, 3982.0443093657314, 4047.5952404759287, 4053.2096241233266, 4067.593240675909, 8643.35174861888, 8736.257418119403, 8740.213380795632, 8742.08208138149, 8746.956265218632, 4388.956110438919, 4451.0, 4459.397981272552, 4460.130274596422, 4462.553744625511, 4048.2915489789757, 4054.2296963577414, 4055.8986025349604, 4059.3505039193587, 4061.5532291447917, 3245.837708114585, 3302.455094909361, 3360.9495857562156, 3465.1856813648774, 3532.5584301962253, 1127.0870594818223, 1138.3795831271977, 1140.2303445174473, 1147.8048731715628, 1158.461315488302, 1067.018343124312, 1067.5836423794726, 1096.1285777806663, 1141.9371934543515, 1302.4659889445472, 6694.364035416725, 6752.561083529555, 6760.019797129388, 6764.323567643196, 6766.15423072116, 986.8766404199475, 989.302541708094, 989.5992123190119, 1011.0395124631482, 1017.6336518853207, 5343.973280133574, 5420.457954204627, 5429.53848922846, 5438.864028399243, 5439.755211015514, 8751.56242187888, 8773.473591584525, 8853.29173666105, 8870.0, 8878.978917424449, 8719.782005449788, 8782.692605758768, 8829.911700883038, 8839.955800220958, 8843.336749743796, 6778.559393639398, 6792.524523283421, 6842.0, 6921.065656136358, 6940.757073502403, 6630.966845165936, 6664.033715111379, 6687.164104486939, 6700.095487109178, 6708.865822683617, 7782.0, 7960.84078318442, 7995.12053674107, 8013.398995075509, 8127.431079824356, 8149.674013039412, 8213.95893020531, 8306.667733290842, 8390.622421990904, 8402.789930251793, 6395.776147834804, 6425.45383642377, 6457.7094030767785, 6478.546501744832, 6486.189226346707, 6428.228612566522, 6464.450521705708, 6566.409023187936, 6586.868262634816, 6644.933550664431, 6462.870742585216, 6579.111819904443, 6627.536072474881, 6635.701393437404, 6813.557118787461, 6363.3000369958345, 6404.647744374104, 6408.166938297992, 6474.5791523550815, 6537.5750576212395, 6501.707423165874, 6524.151860258136, 6565.982272747732, 6566.868662626816, 6571.80284591463, 6065.8180254592435, 6085.695715214133, 6098.725557350019, 6118.694065296806, 6119.357467465852, 6015.879682406415, 6118.143459915526, 6120.020796672511, 6136.386361363828, 6136.969315153396], "unit": "score", "name": "mootools.html", "value": 4219.652207882208}, {"lowerIsBetter": false, "replicates": [303.65686773945447, 310.4319096054221, 315.728473512779, 316.50941041385863, 318.39187152538653, 5966.105084237367, 6102.908456373152, 6123.173371594833, 6124.265088189412, 6133.50931925446, 5977.40225977402, 5979.0, 6000.909986350197, 6004.039353703409, 6004.07869481766, 4441.244988351972, 4512.909741805179, 4628.282616194495, 4628.768561571908, 4629.513901040401, 4566.794494247767, 4653.581177694007, 4659.044895796354, 4670.182718024349, 4676.064787042588, 4608.055348653518, 4611.861644150681, 4617.746023968681, 4624.375709279255, 4626.560476754703, 4355.978220108895, 4416.911661766747, 4434.046679963791, 4440.111977604492, 4608.078384323132, 3958.9010274743073, 3985.0, 4015.0765323975356, 4024.6981476389387, 4031.9516925599555, 5576.9163462548095, 5645.8588535286535, 5647.830565083054, 5648.039833228361, 5651.830445086613, 5381.623286369956, 5383.650062745909, 5385.380681221632, 5385.78456861729, 5394.298741163623, 6217.906731398987, 6410.134631824691, 6423.132877061584, 6428.485721142298, 6428.61428314298, 4484.8430304939175, 4488.932666010012, 4490.236659767847, 4490.550944905516, 4497.820087196508, 6607.768728094494, 6700.564463309918, 6703.664816759143, 6708.496862735315, 6714.093597364391, 4409.074094440203, 4516.570925762047, 4518.502964673883, 4623.0, 4628.861134165981, 4567.3377360282575, 4571.337156112345, 4572.8399506017795, 4623.237165867661, 4635.791389387486, 5347.876945841417, 5349.384820745586, 5351.973240133852, 5357.919631205457, 5358.115910874662, 6428.742850286029, 6448.097266382711, 6453.064305675744, 6454.483641308778, 6460.483161347081, 1591.8089829220567, 1661.3437692111547, 1663.3097264635282, 1665.0342801175289, 1667.5080851148941, 1057.376148072641, 1090.5583238788304, 1090.8800031996475, 1094.3980810554162, 1112.3881864974394, 6122.357152498924, 6122.448979591858, 6136.2636483622255, 6141.969290153521, 6146.815595532141, 6540.215174179034, 6545.05096760967, 6563.081168636395, 6572.671366431659, 6582.341765823475, 5995.880082398327, 6074.088886667036, 6074.271087469532, 6077.939220607737, 6096.116063170815, 3531.4879342495196, 3565.4830049642655, 3569.37535931211, 3572.1783989682, 3573.6426357364057, 6807.863842723118, 6834.1457317835275, 6836.760713375107, 6840.281770414134, 6846.281140480278, 6668.733250670016, 6760.966195168992, 6767.086443330186, 6769.763058292936, 6770.5599136056, 6786.0, 6829.795106146824, 6840.247572766992, 6851.691673874688, 6857.108575885203, 6558.409743123142, 6562.507811914221, 6571.178602674666, 6573.244076931022, 6574.0796288520605, 6402.487800975818, 6542.149520562297, 6547.770828020996, 6551.44312733423, 6561.967190164019, 6823.044773731583, 6832.658367081725, 6834.863302733818, 6835.760748373982, 6838.829029274308, 4607.838725644587, 4609.861704148881, 4612.884677883079, 4617.699849509771, 4621.60716339115, 6615.702293396713, 6621.1392518972225, 6629.071929929717, 6629.569078009914, 6634.303398143125, 6274.623522588659, 6406.5515413920575, 6433.0057682118695, 6434.227892652912, 6439.7424103035355, 6409.679516024087, 6418.839529011812, 6422.550421470452, 6424.646644434414, 6425.0, 6201.875962480815, 6299.748010079546, 6308.053791931064, 6310.52671049664, 6311.96844015777, 6369.8726025480155, 6436.16329877113, 6438.90341644885, 6450.774222902176, 6459.418652321314, 6263.74945002213, 6285.465735412358, 6286.717097730704, 6294.779682711083, 6295.779647712491], "unit": "score", "name": "prototype.html", "value": 4818.6366737648805}, {"lowerIsBetter": false, "replicates": [780.5706861226325, 835.5237514616667, 835.586384739554, 850.4897061762942, 851.8679604661276, 12884.742305153903, 13029.0, 13049.478020879153, 13049.67375815605, 13129.671758206037, 11691.29852208868, 12746.235225886454, 12830.166039207468, 12833.743325133491, 12835.294058826761, 675.2875716119491, 823.2261674026425, 835.7868743470407, 836.7029704454923, 841.1798496465958, 815.042325267808, 816.1185919207242, 821.109096630157, 824.2581676491146, 824.2746383182791, 706.071515956518, 715.0418439291349, 872.1714371347246, 880.4321212817729, 880.7798050487378, 853.9146085391474, 870.6778491957984, 872.0930232558195, 873.7859224489977, 876.772039269788, 640.7693230437039, 642.9324920883333, 643.1510406263734, 643.2602507116807, 643.5302229372584, 12940.352982350845, 13049.673758156123, 13074.803877941838, 13086.214827110403, 13114.278714670689, 11949.880501194964, 12449.128561000734, 12539.31033793141, 12746.617601471971, 13177.670558236025, 10319.226058045602, 10335.121514671187, 10516.158707303397, 10604.204684648683, 10838.458077096113, 3654.5979942206336, 3665.5601327840563, 3693.6675699186935, 3731.2910546996254, 3838.2899163654815, 47037.0, 47448.76275618634, 47561.524384756056, 47621.76189119067, 48513.514864851255, 9612.51937403127, 9764.853527196956, 9811.362261452983, 9862.457564834003, 9887.604495820087, 16411.753823692656, 16414.917925410296, 16476.258568364454, 16478.2584783685, 16491.505254842374, 7338.596377199198, 7427.294407031323, 7542.132654744774, 7637.579933103732, 7735.071791385069, 4319.265724826724, 4411.316245981878, 4421.425214722066, 4424.535423780521, 4442.955570444319, 2973.405318936178, 2992.7755418343713, 3002.3695024045196, 3004.038707613586, 3006.353633968707, 523.3118449239238, 545.2638937434511, 550.8154768152714, 555.4556534596119, 557.3256359804682, 568.46848196936, 633.9568730746897, 637.7773459493661, 646.1714342520547, 671.6641679160322, 8448.57757112142, 8934.86597701035, 9242.907570924339, 9263.814723705487, 9384.202342800801, 494.7377889718455, 577.7313549199642, 626.949844012487, 627.2347735762363, 647.2297965421134, 3866.4007078902814, 4077.959220407817, 4089.44792453021, 4283.400323954649, 4485.0, 54710.72644636831, 55842.72078639581, 55929.0, 55942.44057559453, 55978.72010639921, 49950.25074623884, 50685.493145068074, 50840.0, 51042.23436648453, 51186.74406627943, 43887.56112438835, 44186.55813441889, 44559.0, 44687.55312446899, 44777.10445791066, 8420.578971051546, 8442.409031367992, 8764.34267429958, 8837.646494140163, 8841.0, 32737.67262327346, 32895.177620559676, 33867.49198761971, 33931.0, 34144.65855341415, 40279.59720402758, 43851.56148438475, 44151.55848441603, 44162.55837441584, 44356.556434435246, 10267.897321026694, 10406.194945704621, 10455.94772026135, 10515.106215971728, 10671.733206669895, 12346.320952347707, 12425.37873106359, 12451.626451206479, 12519.874801251872, 12578.245305281713, 11200.215984881306, 11301.547938082385, 11337.773244534897, 11522.193446458667, 11737.295762254293, 11139.72150696239, 11202.103831693283, 11539.88460115388, 11694.181407301407, 11816.0, 7799.571452118053, 10484.737881553023, 11310.830337545109, 11463.885361146282, 11717.355545444741, 9926.851097233692, 10111.443870586894, 10162.339447935861, 10194.031567001122, 10433.686989390331, 8981.820363592822, 9091.272698184262, 9315.534223288672, 9328.860067099135, 9535.952320238355], "unit": "score", "name": "yui.html", "value": 6237.14256468349}], "name": "dromaeo_css", "value": 6792.7755058479415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 109.0, 111.0, 111.0, 100.0, 111.0, 113.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [148.0, 122.0, 147.0, 165.0, 138.0, 160.0, 156.0, 123.0, 166.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 160.0, 163.0, 162.0, 162.0, 162.0, 159.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 84.0, 96.0, 72.0, 75.0, 74.0, 111.0, 88.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 140.0, 95.0, 96.0, 96.0, 148.0, 95.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 148.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 57.0, 57.0, 56.0, 57.0, 64.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 89.0, 88.0, 86.0, 86.0, 86.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [130.0, 115.0, 120.0, 115.0, 120.0, 135.0, 120.0, 125.0, 118.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [138.0, 152.0, 150.0, 148.0, 147.0, 149.0, 148.0, 159.0, 148.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1503.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.9261125104954], "unit": "score", "name": "Richards", "value": 210.22340999999997}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5278.9473684210525], "unit": "score", "name": "Decrypt", "value": 50.423120638085756}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [807.1025020177563], "unit": "score", "name": "Earley", "value": 825.7476570000002}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [26473.684210526317], "unit": "score", "name": "RegExp", "value": 34.410964214711704}, {"lowerIsBetter": false, "replicates": [573.0659025787966], "unit": "score", "name": "Splay", "value": 142.20179499999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19757.66824601681}]} 14:13:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19757.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6792.78"}}} 14:13:36 INFO - Return code: 0 14:13:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:13:36 INFO - # TBPL SUCCESS # 14:13:36 INFO - Running post-action listener: _resource_record_post_action 14:13:36 INFO - Running post-run listener: _resource_record_post_run 14:13:37 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545259520; Read time: 4; Write time: 379292 14:13:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234430464; Read time: 0; Write time: 181388 14:13:37 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309960704; Read time: 4; Write time: 197856 14:13:37 INFO - Running post-run listener: _upload_blobber_files 14:13:37 INFO - Blob upload gear active. 14:13:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:13:37 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 14:13:37 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:13:37 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:13:38 INFO - (blobuploader) - INFO - Open directory for files ... 14:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:40 INFO - (blobuploader) - INFO - Done attempting. 14:13:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:13:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:40 INFO - (blobuploader) - INFO - Done attempting. 14:13:40 INFO - (blobuploader) - INFO - Iteration through files over. 14:13:40 INFO - Return code: 0 14:13:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:13:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:13:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21acc5b32b03c25b825477a6052608ae1acdd1b6fc4646ec80fbf52c22cefde6dff22928fda87a233d6d289761bfa484301fbc47cf87fe5dcd235d8d041186d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c020b7433f8ab715b84859eefad787cae54f3b8a684132e7a070cabb933f1fc44f8c57b9ead7b6647357082e92292db0c435d96344a381afd3876c9cb901019"} 14:13:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:13:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:13:40 INFO - Contents: 14:13:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21acc5b32b03c25b825477a6052608ae1acdd1b6fc4646ec80fbf52c22cefde6dff22928fda87a233d6d289761bfa484301fbc47cf87fe5dcd235d8d041186d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c020b7433f8ab715b84859eefad787cae54f3b8a684132e7a070cabb933f1fc44f8c57b9ead7b6647357082e92292db0c435d96344a381afd3876c9cb901019"} 14:13:40 INFO - Copying logs to upload dir... 14:13:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.851891 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-26 14:13:39.740110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 14:13:39.744356) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21acc5b32b03c25b825477a6052608ae1acdd1b6fc4646ec80fbf52c22cefde6dff22928fda87a233d6d289761bfa484301fbc47cf87fe5dcd235d8d041186d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c020b7433f8ab715b84859eefad787cae54f3b8a684132e7a070cabb933f1fc44f8c57b9ead7b6647357082e92292db0c435d96344a381afd3876c9cb901019"} build_url:https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/01m3BHFXTA-On70-qjD06w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21acc5b32b03c25b825477a6052608ae1acdd1b6fc4646ec80fbf52c22cefde6dff22928fda87a233d6d289761bfa484301fbc47cf87fe5dcd235d8d041186d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c020b7433f8ab715b84859eefad787cae54f3b8a684132e7a070cabb933f1fc44f8c57b9ead7b6647357082e92292db0c435d96344a381afd3876c9cb901019"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 14:13:39.771457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 14:13:39.771774) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451159788.404707-93147792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 14:13:39.852928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 14:13:39.853258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 14:13:39.853547) ========= ========= Total master_lag: 0.34 =========