builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1451447329.63 results: success (0) buildid: 20151229173003 builduid: c7485194aa5f4040a0b0b223930eed9f revision: e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.625576) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.626141) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.626567) ========= 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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.665310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.665745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.685481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.685769) ========= 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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.735699) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.736007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.736399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.736710) ========= 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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 19:48:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-29 19:48:50 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.925572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.925890) ========= 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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.975027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:49.975352) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 --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 e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 --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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 19:48:50,470 truncating revision to first 12 chars 2015-12-29 19:48:50,470 Setting DEBUG logging. 2015-12-29 19:48:50,470 attempt 1/10 2015-12-29 19:48:50,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e873ef1df11f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 19:48:50,720 unpacking tar archive at: fx-team-e873ef1df11f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:50.531092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:50.531411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:50.541599) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:50.541862) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:50.542259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-29 19:48:50.542589) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --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', '--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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:48:51 INFO - MultiFileLogger online at 20151229 19:48:51 in /builds/slave/test-pgo 19:48:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:48:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:48:51 INFO - {'append_to_log': False, 19:48:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:48:51 INFO - 'blob_upload_branch': 'Fx-Team', 19:48:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:48:51 INFO - 'branch': 'Fx-Team', 19:48:51 INFO - 'buildbot_json_path': 'buildprops.json', 19:48:51 INFO - 'config_files': ('talos/linux_config.py',), 19:48:51 INFO - 'default_actions': ('clobber', 19:48:51 INFO - 'read-buildbot-config', 19:48:51 INFO - 'download-and-extract', 19:48:51 INFO - 'populate-webroot', 19:48:51 INFO - 'create-virtualenv', 19:48:51 INFO - 'install', 19:48:51 INFO - 'run-tests'), 19:48:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:48:51 INFO - 'download_minidump_stackwalk': True, 19:48:51 INFO - 'download_symbols': 'ondemand', 19:48:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:48:51 INFO - 'tooltool.py': '/tools/tooltool.py', 19:48:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:48:51 INFO - '/tools/misc-python/virtualenv.py')}, 19:48:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:48:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:48:51 INFO - 'installer_path': 'installer.exe', 19:48:51 INFO - 'log_level': 'info', 19:48:51 INFO - 'log_name': 'talos', 19:48:51 INFO - 'log_to_console': True, 19:48:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:48:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:48:51 INFO - 'opt_config_files': (), 19:48:51 INFO - 'pip_index': False, 19:48:51 INFO - 'sps_profile': False, 19:48:51 INFO - 'sps_profile_interval': 0, 19:48:51 INFO - 'suite': 'dromaeojs', 19:48:51 INFO - 'system_bits': '32', 19:48:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:48:51 INFO - 'title': 'talos-linux64-ix-017', 19:48:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:48:51 INFO - 'use_talos_json': True, 19:48:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:48:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:48:51 INFO - 'work_dir': 'build'} 19:48:51 INFO - ##### 19:48:51 INFO - ##### Running clobber step. 19:48:51 INFO - ##### 19:48:51 INFO - Running pre-action listener: _resource_record_pre_action 19:48:51 INFO - Running main action method: clobber 19:48:51 INFO - rmtree: /builds/slave/test-pgo/build 19:48:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:48:51 INFO - Running post-action listener: _resource_record_post_action 19:48:51 INFO - ##### 19:48:51 INFO - ##### Running read-buildbot-config step. 19:48:51 INFO - ##### 19:48:51 INFO - Running pre-action listener: _resource_record_pre_action 19:48:51 INFO - Running main action method: read_buildbot_config 19:48:51 INFO - Using buildbot properties: 19:48:51 INFO - { 19:48:51 INFO - "project": "", 19:48:51 INFO - "product": "firefox", 19:48:51 INFO - "script_repo_revision": "production", 19:48:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:48:51 INFO - "repository": "", 19:48:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:48:51 INFO - "buildid": "20151229173003", 19:48:51 INFO - "pgo_build": "True", 19:48:51 INFO - "basedir": "/builds/slave/test-pgo", 19:48:51 INFO - "buildnumber": 562, 19:48:51 INFO - "slavename": "talos-linux64-ix-017", 19:48:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:48:51 INFO - "platform": "ubuntu64_hw", 19:48:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:48:51 INFO - "branch": "fx-team", 19:48:51 INFO - "repo_path": "integration/fx-team", 19:48:51 INFO - "revision": "e873ef1df11f7c0538ec2dd5f53a6568c4bb7005", 19:48:51 INFO - "stage_platform": "linux64-pgo", 19:48:51 INFO - "builduid": "c7485194aa5f4040a0b0b223930eed9f", 19:48:51 INFO - "slavebuilddir": "test" 19:48:51 INFO - } 19:48:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:48:51 INFO - Running post-action listener: _resource_record_post_action 19:48:51 INFO - ##### 19:48:51 INFO - ##### Running download-and-extract step. 19:48:51 INFO - ##### 19:48:51 INFO - Running pre-action listener: _resource_record_pre_action 19:48:51 INFO - Running main action method: download_and_extract 19:48:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:48:51 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')]} 19:48:51 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json 19:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json 19:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:48:52 INFO - Downloaded 1302 bytes. 19:48:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:48:52 INFO - Using the following test package requirements: 19:48:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:48:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:52 INFO - u'jsshell-linux-x86_64.zip'], 19:48:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:48:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:48:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:48:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:48:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:48:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:48: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')]} 19:48:52 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:53 INFO - Downloaded 23192308 bytes. 19:48:53 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 19:48:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:53 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 19:48:54 INFO - Return code: 0 19:48:54 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 19:48: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')]} 19:48:54 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:55 INFO - Downloaded 23192308 bytes. 19:48:55 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 19:48:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:55 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 19:48:57 INFO - Return code: 0 19:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:57 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:48:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:57 INFO - Downloaded 11132270 bytes. 19:48:57 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 19:48:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:57 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 19:48:58 INFO - Return code: 0 19:48: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')]} 19:48:58 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:48:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:59 INFO - Downloaded 54900623 bytes. 19:48:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:59 INFO - mkdir: /builds/slave/test-pgo/properties 19:48:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:48:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:48:59 INFO - Contents: 19:48:59 INFO - build_url:https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:59 INFO - Running post-action listener: _resource_record_post_action 19:48:59 INFO - Running post-action listener: set_extra_try_arguments 19:48:59 INFO - ##### 19:48:59 INFO - ##### Running populate-webroot step. 19:48:59 INFO - ##### 19:48:59 INFO - Running pre-action listener: _resource_record_pre_action 19:48:59 INFO - Running main action method: populate_webroot 19:48:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:48:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:48:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:48:59 INFO - '--tppagecycles', 19:48:59 INFO - '7'], 19:48:59 INFO - 'tests': ['tsvgm']}}, 19:48:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:48:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:48:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:48:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:48:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'tests': ['damp', 'tps']}, 19:48:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['damp', 'tps']}, 19:48:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:48:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:48:59 INFO - 'other': {'tests': ['a11yr', 19:48:59 INFO - 'ts_paint', 19:48:59 INFO - 'tpaint', 19:48:59 INFO - 'sessionrestore', 19:48:59 INFO - 'sessionrestore_no_auto_restore']}, 19:48:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['a11yr', 19:48:59 INFO - 'ts_paint', 19:48:59 INFO - 'tpaint', 19:48:59 INFO - 'sessionrestore', 19:48:59 INFO - 'sessionrestore_no_auto_restore']}, 19:48:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['a11yr', 19:48:59 INFO - 'ts_paint', 19:48:59 INFO - 'tpaint', 19:48:59 INFO - 'sessionrestore', 19:48:59 INFO - 'sessionrestore_no_auto_restore']}, 19:48:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['a11yr', 19:48:59 INFO - 'ts_paint', 19:48:59 INFO - 'tpaint', 19:48:59 INFO - 'sessionrestore', 19:48:59 INFO - 'sessionrestore_no_auto_restore']}, 19:48:59 INFO - 'other_l64': {'tests': ['a11yr', 19:48:59 INFO - 'ts_paint', 19:48:59 INFO - 'tpaint', 19:48:59 INFO - 'sessionrestore', 19:48:59 INFO - 'sessionrestore_no_auto_restore']}, 19:48:59 INFO - 'other_nol64': {'tests': ['a11yr', 19:48:59 INFO - 'ts_paint', 19:48:59 INFO - 'tpaint', 19:48:59 INFO - 'sessionrestore', 19:48:59 INFO - 'sessionrestore_no_auto_restore']}, 19:48:59 INFO - 'svgr': {'tests': ['tsvgx', 19:48:59 INFO - 'tsvgr_opacity', 19:48:59 INFO - 'tart', 19:48:59 INFO - 'tscrollx', 19:48:59 INFO - 'cart']}, 19:48:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['tsvgx', 19:48:59 INFO - 'tsvgr_opacity', 19:48:59 INFO - 'tart', 19:48:59 INFO - 'tscrollx', 19:48:59 INFO - 'cart']}, 19:48:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'tests': ['tp5o']}, 19:48:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'talos_options': ['--e10s'], 19:48:59 INFO - 'tests': ['tp5o']}, 19:48:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'talos_options': ['--xperf_path', 19:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:59 INFO - 'tests': ['tp5n']}, 19:48:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:59 INFO - 'talos_options': ['--e10s', 19:48:59 INFO - '--xperf_path', 19:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:59 INFO - 'tests': ['tp5n']}}, 19:48:59 INFO - 'talos.zip': {'path': '', 19:48:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:48:59 INFO - Running post-action listener: _resource_record_post_action 19:48:59 INFO - ##### 19:48:59 INFO - ##### Running create-virtualenv step. 19:48:59 INFO - ##### 19:48:59 INFO - Running pre-action listener: _resource_record_pre_action 19:48:59 INFO - Running main action method: create_virtualenv 19:48:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:48:59 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 19:48:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:48:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:48:59 INFO - Using real prefix '/usr' 19:48:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:49:00 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:02 INFO - Installing pip.................done. 19:49:02 INFO - Return code: 0 19:49:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:49:02 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')]} 19:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:02 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')]} 19:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:02 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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:02 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 19:49:02 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 19:49:02 INFO - Using env: {'DISPLAY': ':0', 19:49:02 INFO - 'HOME': '/home/cltbld', 19:49:02 INFO - 'LANG': 'en_US.UTF-8', 19:49:02 INFO - 'LANGUAGE': 'en_US:en', 19:49:02 INFO - 'LOGNAME': 'cltbld', 19:49:02 INFO - 'MAIL': '/var/mail/cltbld', 19:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:02 INFO - 'MOZ_NO_REMOTE': '1', 19:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:02 INFO - 'NO_EM_RESTART': '1', 19:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:02 INFO - 'SHELL': '/bin/bash', 19:49:02 INFO - 'SHLVL': '1', 19:49:02 INFO - 'TERM': 'linux', 19:49:02 INFO - 'TMOUT': '86400', 19:49:02 INFO - 'USER': 'cltbld', 19:49:02 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:02 INFO - '_': '/tools/buildbot/bin/python'} 19:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:02 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 19:49:02 INFO - Cleaning up... 19:49:02 INFO - Return code: 0 19:49:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:49:02 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')]} 19:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:02 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')]} 19:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:02 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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:02 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 19:49:02 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 19:49:02 INFO - Using env: {'DISPLAY': ':0', 19:49:02 INFO - 'HOME': '/home/cltbld', 19:49:02 INFO - 'LANG': 'en_US.UTF-8', 19:49:02 INFO - 'LANGUAGE': 'en_US:en', 19:49:02 INFO - 'LOGNAME': 'cltbld', 19:49:02 INFO - 'MAIL': '/var/mail/cltbld', 19:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:02 INFO - 'MOZ_NO_REMOTE': '1', 19:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:02 INFO - 'NO_EM_RESTART': '1', 19:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:02 INFO - 'SHELL': '/bin/bash', 19:49:02 INFO - 'SHLVL': '1', 19:49:02 INFO - 'TERM': 'linux', 19:49:02 INFO - 'TMOUT': '86400', 19:49:02 INFO - 'USER': 'cltbld', 19:49:02 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:02 INFO - '_': '/tools/buildbot/bin/python'} 19:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:02 INFO - Downloading/unpacking psutil>=0.7.1 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:49:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:04 INFO - Installing collected packages: psutil 19:49:04 INFO - Running setup.py install for psutil 19:49:04 INFO - building 'psutil._psutil_linux' extension 19:49:04 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 19:49:04 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 19:49:04 INFO - building 'psutil._psutil_posix' extension 19:49:04 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 19:49:04 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 19:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:04 INFO - Successfully installed psutil 19:49:04 INFO - Cleaning up... 19:49:04 INFO - Return code: 0 19:49:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:49: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')]} 19:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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', '--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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:04 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 19:49:04 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 19:49:04 INFO - Using env: {'DISPLAY': ':0', 19:49:04 INFO - 'HOME': '/home/cltbld', 19:49:04 INFO - 'LANG': 'en_US.UTF-8', 19:49:04 INFO - 'LANGUAGE': 'en_US:en', 19:49:04 INFO - 'LOGNAME': 'cltbld', 19:49:04 INFO - 'MAIL': '/var/mail/cltbld', 19:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:04 INFO - 'MOZ_NO_REMOTE': '1', 19:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:04 INFO - 'NO_EM_RESTART': '1', 19:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:04 INFO - 'SHELL': '/bin/bash', 19:49:04 INFO - 'SHLVL': '1', 19:49:04 INFO - 'TERM': 'linux', 19:49:04 INFO - 'TMOUT': '86400', 19:49:04 INFO - 'USER': 'cltbld', 19:49:04 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:04 INFO - '_': '/tools/buildbot/bin/python'} 19:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:49:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:49:06 INFO - Installing collected packages: mozsystemmonitor 19:49:06 INFO - Running setup.py install for mozsystemmonitor 19:49:06 INFO - Successfully installed mozsystemmonitor 19:49:06 INFO - Cleaning up... 19:49:06 INFO - Return code: 0 19:49:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:49:06 INFO - Using env: {'DISPLAY': ':0', 19:49:06 INFO - 'HOME': '/home/cltbld', 19:49:06 INFO - 'LANG': 'en_US.UTF-8', 19:49:06 INFO - 'LANGUAGE': 'en_US:en', 19:49:06 INFO - 'LOGNAME': 'cltbld', 19:49:06 INFO - 'MAIL': '/var/mail/cltbld', 19:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:06 INFO - 'MOZ_NO_REMOTE': '1', 19:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:06 INFO - 'NO_EM_RESTART': '1', 19:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:06 INFO - 'SHELL': '/bin/bash', 19:49:06 INFO - 'SHLVL': '1', 19:49:06 INFO - 'TERM': 'linux', 19:49:06 INFO - 'TMOUT': '86400', 19:49:06 INFO - 'USER': 'cltbld', 19:49:06 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:06 INFO - '_': '/tools/buildbot/bin/python'} 19:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:07 INFO - Downloading/unpacking blobuploader==1.2.4 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:49:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:49:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:49:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:49:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:09 INFO - Downloading docopt-0.6.1.tar.gz 19:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:49:09 INFO - Installing collected packages: blobuploader, requests, docopt 19:49:09 INFO - Running setup.py install for blobuploader 19:49:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:49:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:49:09 INFO - Running setup.py install for requests 19:49:09 INFO - Running setup.py install for docopt 19:49:10 INFO - Successfully installed blobuploader requests docopt 19:49:10 INFO - Cleaning up... 19:49:10 INFO - Return code: 0 19:49:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:10 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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:10 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 19:49:10 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 19:49:10 INFO - Using env: {'DISPLAY': ':0', 19:49:10 INFO - 'HOME': '/home/cltbld', 19:49:10 INFO - 'LANG': 'en_US.UTF-8', 19:49:10 INFO - 'LANGUAGE': 'en_US:en', 19:49:10 INFO - 'LOGNAME': 'cltbld', 19:49:10 INFO - 'MAIL': '/var/mail/cltbld', 19:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:10 INFO - 'MOZ_NO_REMOTE': '1', 19:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:10 INFO - 'NO_EM_RESTART': '1', 19:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:10 INFO - 'SHELL': '/bin/bash', 19:49:10 INFO - 'SHLVL': '1', 19:49:10 INFO - 'TERM': 'linux', 19:49:10 INFO - 'TMOUT': '86400', 19:49:10 INFO - 'USER': 'cltbld', 19:49:10 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:10 INFO - '_': '/tools/buildbot/bin/python'} 19:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:10 INFO - Running setup.py (path:/tmp/pip-wSbtEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:10 INFO - Running setup.py (path:/tmp/pip-3DbtBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:10 INFO - Running setup.py (path:/tmp/pip-_5oiGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:10 INFO - Running setup.py (path:/tmp/pip-EIxtS3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:10 INFO - Running setup.py (path:/tmp/pip-UIQobf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:10 INFO - Running setup.py (path:/tmp/pip-SAlszc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:10 INFO - Running setup.py (path:/tmp/pip-iOmlxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:10 INFO - Running setup.py (path:/tmp/pip-hfStCL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:10 INFO - Running setup.py (path:/tmp/pip-XLrv3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:10 INFO - Running setup.py (path:/tmp/pip-fa29vt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:11 INFO - Running setup.py (path:/tmp/pip-UZ0VkR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:11 INFO - Running setup.py (path:/tmp/pip-6RKbP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:11 INFO - Running setup.py (path:/tmp/pip-KFO2sg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:11 INFO - Running setup.py (path:/tmp/pip-gQc8IZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:11 INFO - Running setup.py (path:/tmp/pip-CFrS9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:11 INFO - Running setup.py (path:/tmp/pip-hItXSh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:11 INFO - Running setup.py (path:/tmp/pip-dyCH_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:49:11 INFO - Running setup.py install for manifestparser 19:49:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:49:11 INFO - Running setup.py install for mozcrash 19:49:11 INFO - Running setup.py install for mozdebug 19:49:11 INFO - Running setup.py install for mozdevice 19:49:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:49:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Running setup.py install for mozfile 19:49:12 INFO - Running setup.py install for mozhttpd 19:49:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Running setup.py install for mozinfo 19:49:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Running setup.py install for mozInstall 19:49:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Running setup.py install for mozleak 19:49:12 INFO - Running setup.py install for mozlog 19:49:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Running setup.py install for moznetwork 19:49:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Running setup.py install for mozprocess 19:49:12 INFO - Running setup.py install for mozprofile 19:49:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:49:12 INFO - Running setup.py install for mozrunner 19:49:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:49:13 INFO - Running setup.py install for mozscreenshot 19:49:13 INFO - Running setup.py install for moztest 19:49:13 INFO - Running setup.py install for mozversion 19:49:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:49:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:49:13 INFO - Cleaning up... 19:49:13 INFO - Return code: 0 19:49:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:13 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')]} 19:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:13 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')]} 19:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:13 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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:13 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 19:49:13 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 19:49:13 INFO - Using env: {'DISPLAY': ':0', 19:49:13 INFO - 'HOME': '/home/cltbld', 19:49:13 INFO - 'LANG': 'en_US.UTF-8', 19:49:13 INFO - 'LANGUAGE': 'en_US:en', 19:49:13 INFO - 'LOGNAME': 'cltbld', 19:49:13 INFO - 'MAIL': '/var/mail/cltbld', 19:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:13 INFO - 'MOZ_NO_REMOTE': '1', 19:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:13 INFO - 'NO_EM_RESTART': '1', 19:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:13 INFO - 'SHELL': '/bin/bash', 19:49:13 INFO - 'SHLVL': '1', 19:49:13 INFO - 'TERM': 'linux', 19:49:13 INFO - 'TMOUT': '86400', 19:49:13 INFO - 'USER': 'cltbld', 19:49:13 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:13 INFO - '_': '/tools/buildbot/bin/python'} 19:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:13 INFO - Running setup.py (path:/tmp/pip-EAN3n_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:13 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)) 19:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:13 INFO - Running setup.py (path:/tmp/pip-osCDtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:13 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)) 19:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:13 INFO - Running setup.py (path:/tmp/pip-HFAXtX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:13 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)) 19:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:13 INFO - Running setup.py (path:/tmp/pip-0S_IU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:13 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)) 19:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:13 INFO - Running setup.py (path:/tmp/pip-HTJuUZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:13 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)) 19:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:13 INFO - Running setup.py (path:/tmp/pip-xcrbGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:14 INFO - Running setup.py (path:/tmp/pip-GoMzK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:14 INFO - Running setup.py (path:/tmp/pip-nF3FL3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:14 INFO - Running setup.py (path:/tmp/pip-o3C1ED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:14 INFO - Running setup.py (path:/tmp/pip-4c9cLs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:14 INFO - Running setup.py (path:/tmp/pip-iaW07h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:14 INFO - Running setup.py (path:/tmp/pip-xjo3O7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:14 INFO - Running setup.py (path:/tmp/pip-y3CU9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:14 INFO - Running setup.py (path:/tmp/pip-DhseYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:14 INFO - Running setup.py (path:/tmp/pip-0RMHWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:14 INFO - Running setup.py (path:/tmp/pip-1N3hrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:14 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)) 19:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:14 INFO - Running setup.py (path:/tmp/pip-QxiUVu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:14 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)) 19:49:14 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)) 19:49:14 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)) 19:49:14 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)) 19:49:14 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)) 19:49:14 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)) 19:49:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:49:14 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 19:49:14 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 19:49:14 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 19:49:14 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 19:49:14 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 19:49:14 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 19:49:16 INFO - Downloading blessings-1.5.1.tar.gz 19:49:16 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 19:49:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:49:16 INFO - Installing collected packages: blessings 19:49:16 INFO - Running setup.py install for blessings 19:49:16 INFO - Successfully installed blessings 19:49:16 INFO - Cleaning up... 19:49:16 INFO - Return code: 0 19:49:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:49:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:16 INFO - Reading from file tmpfile_stdout 19:49:16 INFO - Current package versions: 19:49:16 INFO - argparse == 1.2.1 19:49:16 INFO - blessings == 1.5.1 19:49:16 INFO - blobuploader == 1.2.4 19:49:16 INFO - docopt == 0.6.1 19:49:16 INFO - manifestparser == 1.1 19:49:16 INFO - mozInstall == 1.12 19:49:16 INFO - mozcrash == 0.16 19:49:16 INFO - mozdebug == 0.1 19:49:16 INFO - mozdevice == 0.47 19:49:16 INFO - mozfile == 1.2 19:49:16 INFO - mozhttpd == 0.7 19:49:16 INFO - mozinfo == 0.9 19:49:16 INFO - mozleak == 0.1 19:49:16 INFO - mozlog == 3.1 19:49:16 INFO - moznetwork == 0.27 19:49:16 INFO - mozprocess == 0.22 19:49:16 INFO - mozprofile == 0.28 19:49:16 INFO - mozrunner == 6.11 19:49:16 INFO - mozscreenshot == 0.1 19:49:16 INFO - mozsystemmonitor == 0.0 19:49:16 INFO - moztest == 0.7 19:49:16 INFO - mozversion == 1.4 19:49:16 INFO - psutil == 3.1.1 19:49:16 INFO - requests == 1.2.3 19:49:16 INFO - wsgiref == 0.1.2 19:49:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:16 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')]} 19:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:16 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')]} 19:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:16 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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:16 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 19:49:16 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 19:49:16 INFO - Using env: {'DISPLAY': ':0', 19:49:16 INFO - 'HOME': '/home/cltbld', 19:49:16 INFO - 'LANG': 'en_US.UTF-8', 19:49:16 INFO - 'LANGUAGE': 'en_US:en', 19:49:16 INFO - 'LOGNAME': 'cltbld', 19:49:16 INFO - 'MAIL': '/var/mail/cltbld', 19:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:16 INFO - 'MOZ_NO_REMOTE': '1', 19:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:16 INFO - 'NO_EM_RESTART': '1', 19:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:16 INFO - 'SHELL': '/bin/bash', 19:49:16 INFO - 'SHLVL': '1', 19:49:16 INFO - 'TERM': 'linux', 19:49:16 INFO - 'TMOUT': '86400', 19:49:16 INFO - 'USER': 'cltbld', 19:49:16 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:16 INFO - '_': '/tools/buildbot/bin/python'} 19:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 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)) 19:49:17 INFO - Cleaning up... 19:49:17 INFO - Return code: 0 19:49:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:17 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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:17 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 19:49:17 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 19:49:17 INFO - Using env: {'DISPLAY': ':0', 19:49:17 INFO - 'HOME': '/home/cltbld', 19:49:17 INFO - 'LANG': 'en_US.UTF-8', 19:49:17 INFO - 'LANGUAGE': 'en_US:en', 19:49:17 INFO - 'LOGNAME': 'cltbld', 19:49:17 INFO - 'MAIL': '/var/mail/cltbld', 19:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:17 INFO - 'MOZ_NO_REMOTE': '1', 19:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:17 INFO - 'NO_EM_RESTART': '1', 19:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:17 INFO - 'SHELL': '/bin/bash', 19:49:17 INFO - 'SHLVL': '1', 19:49:17 INFO - 'TERM': 'linux', 19:49:17 INFO - 'TMOUT': '86400', 19:49:17 INFO - 'USER': 'cltbld', 19:49:17 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:17 INFO - '_': '/tools/buildbot/bin/python'} 19:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:17 INFO - Downloading/unpacking jsonschema 19:49:17 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 19:49:17 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 19:49:17 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 19:49:17 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 19:49:17 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 19:49:17 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 19:49:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:49:19 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 19:49:19 INFO - Downloading/unpacking functools32 (from jsonschema) 19:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:49:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:49:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:49:19 INFO - warning: no files found matching '*.txt' 19:49:19 INFO - no previously-included directories found matching 'build' 19:49:19 INFO - no previously-included directories found matching 'dist' 19:49:19 INFO - no previously-included directories found matching '.git*' 19:49:19 INFO - Installing collected packages: jsonschema, functools32 19:49:19 INFO - Running setup.py install for functools32 19:49:19 INFO - warning: no files found matching '*.txt' 19:49:19 INFO - no previously-included directories found matching 'build' 19:49:19 INFO - no previously-included directories found matching 'dist' 19:49:19 INFO - no previously-included directories found matching '.git*' 19:49:19 INFO - Successfully installed jsonschema functools32 19:49:19 INFO - Cleaning up... 19:49:19 INFO - Return code: 0 19:49:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:19 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 0x7f77bc21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, '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': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', '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 19:49:19 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 19:49:19 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 19:49:19 INFO - Using env: {'DISPLAY': ':0', 19:49:19 INFO - 'HOME': '/home/cltbld', 19:49:19 INFO - 'LANG': 'en_US.UTF-8', 19:49:19 INFO - 'LANGUAGE': 'en_US:en', 19:49:19 INFO - 'LOGNAME': 'cltbld', 19:49:19 INFO - 'MAIL': '/var/mail/cltbld', 19:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:19 INFO - 'MOZ_NO_REMOTE': '1', 19:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:19 INFO - 'NO_EM_RESTART': '1', 19:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:19 INFO - 'SHELL': '/bin/bash', 19:49:19 INFO - 'SHLVL': '1', 19:49:19 INFO - 'TERM': 'linux', 19:49:19 INFO - 'TMOUT': '86400', 19:49:19 INFO - 'USER': 'cltbld', 19:49:19 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:19 INFO - '_': '/tools/buildbot/bin/python'} 19:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:19 INFO - Downloading/unpacking flake8 19:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:49:21 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 19:49:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:49:21 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 19:49:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:21 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 19:49:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:49:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:22 INFO - no previously-included directories found matching 'docs/_build' 19:49:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:49:22 INFO - Running setup.py install for pep8 19:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:22 INFO - no previously-included directories found matching 'docs/_build' 19:49:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:49:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:49:22 INFO - Cleaning up... 19:49:22 INFO - Return code: 0 19:49:22 INFO - Running post-action listener: _resource_record_post_action 19:49:22 INFO - Running post-action listener: _start_resource_monitoring 19:49:22 INFO - Starting resource monitoring. 19:49:22 INFO - ##### 19:49:22 INFO - ##### Running install step. 19:49:22 INFO - ##### 19:49:22 INFO - Running pre-action listener: _resource_record_pre_action 19:49:22 INFO - Running main action method: install 19:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:22 INFO - Reading from file tmpfile_stdout 19:49:22 INFO - Detecting whether we're running mozinstall >=1.0... 19:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:49:22 INFO - Reading from file tmpfile_stdout 19:49:22 INFO - Output received: 19:49:22 INFO - Usage: mozinstall [options] installer 19:49:22 INFO - Options: 19:49:22 INFO - -h, --help show this help message and exit 19:49:22 INFO - -d DEST, --destination=DEST 19:49:22 INFO - Directory to install application into. [default: 19:49:22 INFO - "/builds/slave/test-pgo"] 19:49:22 INFO - --app=APP Application being installed. [default: firefox] 19:49:22 INFO - mkdir: /builds/slave/test-pgo/build/application 19:49:22 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'] 19:49:22 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 19:49:38 INFO - Reading from file tmpfile_stdout 19:49:38 INFO - Output received: 19:49:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:49:38 INFO - Running post-action listener: _resource_record_post_action 19:49:38 INFO - ##### 19:49:38 INFO - ##### Running run-tests step. 19:49:38 INFO - ##### 19:49:38 INFO - Running pre-action listener: _resource_record_pre_action 19:49:38 INFO - Running main action method: run_tests 19:49:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:49:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:49:38 INFO - Python 2.7.3 19:49:38 INFO - Return code: 0 19:49:38 INFO - grabbing minidump binary from tooltool 19:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:38 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 0x2ae0660>, '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 0x2ae1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:49:38 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 19:49:38 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 19:49:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:49:38 INFO - Return code: 0 19:49:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:49:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:49:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:49:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:49:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:49:39 INFO - Return code: 0 19:49:39 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/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 19:49:39 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/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 19:49:39 INFO - Using env: {'DISPLAY': ':0', 19:49:39 INFO - 'HOME': '/home/cltbld', 19:49:39 INFO - 'LANG': 'en_US.UTF-8', 19:49:39 INFO - 'LANGUAGE': 'en_US:en', 19:49:39 INFO - 'LOGNAME': 'cltbld', 19:49:39 INFO - 'MAIL': '/var/mail/cltbld', 19:49:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:39 INFO - 'MOZ_NO_REMOTE': '1', 19:49:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:39 INFO - 'NO_EM_RESTART': '1', 19:49:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:49:39 INFO - 'SHELL': '/bin/bash', 19:49:39 INFO - 'SHLVL': '1', 19:49:39 INFO - 'TERM': 'linux', 19:49:39 INFO - 'TMOUT': '86400', 19:49:39 INFO - 'USER': 'cltbld', 19:49:39 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373', 19:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:39 INFO - '_': '/tools/buildbot/bin/python'} 19:49:39 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/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 19:49:39 INFO - mozversion application_buildid: 20151229173003 19:49:39 INFO - mozversion application_changeset: e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 19:49:39 INFO - mozversion application_display_name: Nightly 19:49:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:49:39 INFO - mozversion application_name: Firefox 19:49:39 INFO - mozversion application_remotingname: firefox 19:49:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:49:39 INFO - mozversion application_vendor: Mozilla 19:49:39 INFO - mozversion application_version: 46.0a1 19:49:39 INFO - mozversion platform_buildid: 20151229173003 19:49:39 INFO - mozversion platform_changeset: e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 19:49:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:49:39 INFO - mozversion platform_version: 46.0a1 19:49:39 INFO - using testdate: 1451447379 19:49:39 INFO - actual date: 1451447379 19:49:39 INFO - starting webserver on 'localhost:51416' 19:49:39 INFO - SUITE-START | Running 3 tests 19:49:39 INFO - TEST-START | dromaeo_css 19:49:39 INFO - operating with platform_type : linux_ 19:49:39 INFO - Initialising browser for dromaeo_css test... 19:49:39 INFO - TEST-INFO | started process 11405 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqduZTq/profile http://localhost:51416/getInfo.html) 19:49:43 INFO - PROCESS | 11405 | __metrics Screen width/height:1600/1200 19:49:43 INFO - PROCESS | 11405 | colorDepth:24 19:49:43 INFO - PROCESS | 11405 | Browser inner width/height: 1024/697 19:49:43 INFO - PROCESS | 11405 | __metrics 19:49:43 INFO - PROCESS | 11405 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:49:43 INFO - PROCESS | 11405 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:49:44 INFO - TEST-INFO | 11405: exit 0 19:49:44 INFO - Browser initialized. 19:49:44 INFO - Running cycle 1/1 for dromaeo_css test... 19:49:44 INFO - TEST-INFO | started process 11497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqduZTq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:56 INFO - PROCESS | 11497 | RSS: Main: 150532096 19:49:56 INFO - PROCESS | 11497 | 19:50:47 INFO - PROCESS | 11497 | 1451447447955 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] 19:52:55 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51416/tests/dromaeo/cssquery-ext.html) 19:52:57 INFO - PROCESS | 11497 | RSS: Main: 329981952 19:52:57 INFO - PROCESS | 11497 | 19:56:00 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-ext.html (next: http://localhost:51416/tests/dromaeo/cssquery-jquery.html) 19:56:00 INFO - PROCESS | 11497 | RSS: Main: 231374848 19:56:00 INFO - PROCESS | 11497 | 19:59:02 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51416/tests/dromaeo/cssquery-mootools.html) 19:59:03 INFO - PROCESS | 11497 | RSS: Main: 232689664 19:59:03 INFO - PROCESS | 11497 | 20:02:04 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51416/tests/dromaeo/cssquery-prototype.html) 20:02:05 INFO - PROCESS | 11497 | RSS: Main: 209690624 20:02:05 INFO - PROCESS | 11497 | 20:05:08 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51416/tests/dromaeo/cssquery-yui.html) 20:05:08 INFO - PROCESS | 11497 | RSS: Main: 215171072 20:05:08 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-yui.html (next: http://localhost:51416/tests/dromaeo/cssquery-dojo.html) 20:08:11 INFO - PROCESS | 11497 | RSS: Main: 268083200 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | __start_tp_report 20:08:11 INFO - PROCESS | 11497 | _x_x_mozilla_page_load 20:08:11 INFO - PROCESS | 11497 | _x_x_mozilla_page_load_details 20:08:11 INFO - PROCESS | 11497 | |i|pagename|runs| 20:08:11 INFO - PROCESS | 11497 | |0;dojo.html;3069.324748555318;3100.3954228925368;3157.8894738684153;3162.177833763221;3174.1112488503218;5024.698518088917;5119.001794650045;5153.974230128849;5179.19722443021;5204.973975130124;5030.195168772997;5094.261332106842;5172.965406918622;5203.2975548300965;5215.400228973669;4527.660425468087;4667.13657973276;4680.063987202565;4746.359241502388;4784.234522476405;4605.838795642153;4735.90528189436;4749.6200303975775;4756.619470442356;4865.221564549673;4626.65300102492;4713.316569097462;4729.810807567693;4731.881702957437;4760.3573517575205;4690.835820746258;4706.74112923789;4717.198076327033;4739.4075740532435;4740.051989602059;4538.183127037132;4622;4679.298105284201;4695.741734204617;4731.1720448921305;4959.256111583255;5029.119904016782;5044.041632089891;5069.949300506984;5085.974570127126;5460.481254280837;5468.644538105011;5469.480399362054;5473.06957817168;5473.972630136864;5392.703401312965;5519;5538;5539.8892022159735;5587.74855131516;5112.335396398445;5125.359330083739;5138.820141295037;5159.74201289934;5202.557782588485;5564.026295398289;5567.777288908398;5567.8886422272135;5577.05190117681;5616.129499927518;5297.258383826267;5348.5186333230195;5355.785768569292;5361.946380536223;5382.273393091961;5377.838664840061;5422.674639521641;5433.456654334614;5490.752916118784;5520.475554822286;5450.345958485007;5451.591130665216;5482.91775623366;5487.341519017744;5492.505674489315;5347.545458635982;5455.072637651609;5473.534749546254;5477.945220547823;5524.309461317335;4225.661947044229;4251.553586873396;4277.7647229402055;4280.892977675583;4288.807003684841;3804.8668296609485;3817.675497582681;3824.961750382516;3845.4808600839087;3847.5960024197616;5127.102757017507;5127.410347809975;5128.564072053842;5128.8461346159675;5134.820281290137;5372.274742909735;5417.4311697272005;5460.6177567569885;5461.644993075437;5494.2857428534035;5170.586353091744;5189.273501709764;5191.922121168185;5196.220566914993;5199.948000520022;4805.063012712558;4814.301926220678;4815.133276010351;4820.68665536739;4858.732769697701;5438.483344082306;5601.103823388238;5601.411851755588;5640.097584386478;5736.62711923732;5495.587830912617;5496.972515137559;5500.559955203494;5502.339719233558;5503.752331145028;5676.5742569308295;5678.716064196691;5694.4590263924865;5706.400827913009;5712.028955077563;5318.042752304622;5404.756785944721;5422.701751403711;5498.945010549844;5548.195511650869;5438.619296649196;5468.0977638690765;5470.507654310972;5491.505764481216;5491.835244942658;5259;5354.6787192767;5360.70516121617;5363.812266570651;5412.78348866041;5246.527812496894;5289.68261904287;5295.099833028471;5307.814226502054;5310.6813591184655;5233.110371236975;5236.659617124875;5238.240455133908;5243.790248390022;5247.632665713363;5309.230161626465;5320.654157479751;5343.7060961647485;5344.091504444176;5422;5263.052650522943;5269.499397557226;5272.86817829542;5301;5317.042932272228 20:08:11 INFO - PROCESS | 11497 | |1;ext.html;546.6993153765428;567.0133966897598;573.796302312679;577.3302968556476;580.7299605683359;28437;36177;36809.81595092021;36874.07814804631;36885.815570922176;40132.197356052864;40659;40749;40801;40869;7306.9770232167275;7399.667014984312;8528.744137675863;8708.695195668153;8709.042005379435;10125;10319.484025798718;10327.122194613466;10327.741806454824;10332.896671033306;10103.84844227337;10210.183185345155;10215;10216.846747298796;10216.948915255412;7517;7712.421568382394;9970.501474926261;10194.133498652624;10397.428141452217;9903.108720215143;9963.103320701099;9994.45030523321;10026.498675066217;10030.498475076218;36758.816205919065;36927.81536092302;37001.444978325344;37237;37307.81346093279;3300.620428650712;3356.3622911646953;3514.859405623772;3969.6177312912464;3995.380715989026;30322.696773032207;30904.227394315098;30946.381072378652;31235.531467028013;31411;3919.7326413618794;3929.469521614574;4003.8798836034966;4034.45534852797;4116.341385378355;264754;266805;268515;268616;268958;53089.46910530845;54199.72900135474;60082;61718.69140654268;63608.363916361166;54061.45938540643;54077;54448.45551544513;54484.45515544794;54484.72757636187;14523;14542.345594448276;14582.708345833023;14583.489577864724;14714.264286785618;10975.231733778559;10984.505697243643;11041.889581104248;11120.666380008613;11315.094792416587;19593;19809.702854457195;19863.30478433248;19925.701114483294;19927.800721992884;7151.749688760972;7346.302101300368;7409.444291678145;7435.219301973323;7467.402607791364;947.9810403791886;970.1850445625709;1008.0876806490138;1032.2464600841279;1047.984280235797;28703.138905832857;28989.855050725033;29316.97390591319;29521;29850.40299194004;999.9000099990088;1019.0777346501428;1038.4340534408766;1041.6458404142477;1125.6496514548646;14561.417543298361;14579.635509112357;14606.34271457787;14845.183514906785;14888.70222595542;303473;306233;307001;307661;307761;48913.51086489161;49733;51053.48946510562;52077;52416.21375679292;1332.0808642036964;1340.6447291467769;1343.3014832287156;1344.0793056756154;1350.3518311210673;25642.358941026625;25980.610290845274;26383.598979678703;27925.045246832527;28029.29926751766;43080.35379469373;43938.34092488679;44014.11971760611;48760;49928.75035624798;192578;193668;193948;194487;194538;30250.69749302479;30476.933307334137;30589.388212236077;30609.846950765103;30638.387232255674;42501.78749106234;42696.58427325868;42991.57008429876;43760;43882;36528.26943461169;37207.25585488221;37592;38025.619743802206;38292.234155317296;37194.44208336823;37273.25453490969;38127.42808857814;38264.80867595644;38559.42160867533;33005.66994330026;33328.1667958303;33473.665263348026;35290;36954.44568331423;32191.51712724358;32989;33364.32197028089;33397.83301083479;33476.665233347354;25204;25400.618990715524;25477.36306592276;25504.489910201322;25573.040883735674 20:08:11 INFO - PROCESS | 11497 | |2;jquery.html;348.1071052749697;350.39906560249176;353.4380335266925;353.7276297251115;354.69850626967076;13400.262985535792;13733.381997810098;15901.363945442168;15963.760543591841;16315.347386104571;15655.765163522556;15828.683426331467;17037.57406064849;17129.400470983517;17183.82816171838;4687.859364219071;4858.368412106422;4860.7326597037145;4862.465128835825;4862.829800956967;3702.0374702577255;3815.7328986970924;4864.464908860023;5256.290400795881;5449.972750136264;5414.864628384302;5437.510624043835;5443.319585051869;5450.56395488362;5463.180522921554;5089.160288552384;5269.209618557209;5274.97362513185;5275.551578115884;5391.676499410048;5087.084324821531;5088.4148322942965;5088.821891233789;5090.465501122403;5090.643654944155;13120;14175.57473275793;19401;20652.5869482611;20740.896295518578;2055.9280425185048;2066.3904148276297;2087.7077209190725;2159.3521943416913;2161.146347192866;9480;9731.172850307732;9750.26872984529;10793.946030269877;13008.739825203444;1793.6681713882974;1843.2719075965053;1854.2860998515534;1874;1929.4308179087063;55022.44977550213;57437.13844292339;58201.7089914552;58228.70885645544;61169.388306116816;10043.347182433119;10227.539760710786;10230.386176829414;10294.095592315445;10394.01256880595;13361.26513041792;13379.732405351839;13385.129966552144;13393.26337051452;13394.799078013837;7422.960785490036;7589.1272503662785;7609.733659321897;7650.693972241048;7657.6554055066545;7066.222715501291;7155.856882862314;7367.5211111277595;7390.96304518474;7443.776686699408;4413.58070983256;4451.7996690148375;4477.104579084196;4518.909621807546;4523.683342166017;1728.438257566296;1782.6702060118919;1783.144090836406;1795.8473529749856;1820.599468117012;851.4040171879709;908.7682640926654;948;985.6648739428485;1037.4501514197336;14314.212718300385;15619;16107.355705771872;16576.83423165753;16678.166091695366;914.7392992996964;943.1040511513952;948.5968463403026;968.5786682792867;994.0258546624349;8860.689875854314;8927.33045021626;9074.954625226832;9076.364654474124;9221.109672517117;571815;572441;578333;584561;589951;76338;76802;77192.61403692946;79640.6017969918;80893.59553202314;1035.2856528994969;1055.7782865598156;1058.2063452410691;1063.9042486176281;1087.9075278601408;14990.47533336328;15256.542303730906;15344.923275383551;15555;15643.608909777347;34120.829395853856;34257.314853702286;35120.29759404849;35354;35462.82268588641;43672.781636092885;44871.102577948914;45264.54735452735;45672.77163614161;46357.304640431095;8744.912550874664;9549.570269337757;9565.473898935625;9571.425714456876;9575.569099390405;13526.323683815966;16392.098434586213;16519.66960660804;16636.334546618;17017.638588913105;11978.221415607957;13531.864681353454;13978.720425591635;14332.355044023252;14466.349014294172;13684.110532815335;14132.22272774966;14156;14286.71426571442;14415.567532974028;13732.588022359345;13776.380062896993;13861.306934653025;14309.57071287863;14446.133232006114;9406.95296523513;9622.123685881186;9624.230061594915;9634.373765705206;9834.459104749021;13417.329133543088;13464.663383415493;13672.52146174879;13863.72272554523;14719.484818031318 20:08:11 INFO - PROCESS | 11497 | |3;mootools.html;1278.1883503974973;1422.7367936931669;1427.9647255739587;1539.5227479481362;1729.0231019473997;6047.576669633122;6679.131712877325;6786.185657721074;6788.083608712822;6805.149356330458;6603;6774.830629234271;6775.559588626736;6779.2542820289855;6784;1841.9263229470805;1870.8035656256102;2037.0833125093693;2078.7921207879244;2115.3971118231307;2122.734658167729;2129.595376878396;2130.1053557505807;2130.648443006902;2134.6050980568566;2074.5332300232476;2080.5214800595872;2125.5430082532253;2128.4253251622054;2132.125828410352;2090.4773806548365;2091.4875855415366;2097.08776682143;2103.463616777727;2115.7778433264516;2076.397844625072;2086.5931143427038;2089.0181614641097;2094.183268525276;2099.391176558796;6864.965675171592;6911.412529934962;6922.03091567181;6922.930770692329;6934.375906168419;4134.297169481196;4194.874153775391;4231.576842315774;4236.9364459533135;4238.321868501025;2773.2928103333725;2838.758705510034;2871.0956048844546;2872.023512005907;2887.7834162437903;847.2713466418875;872.7948932000975;876.1895246896595;923.1922068190333;933.1368484152132;9023.187913087788;9035.45787252767;9037.728868133967;9050.140236677571;9070.319726020574;3797.6202379761803;3808.6572208501366;3858.074062225046;3871.7483363581277;3880.78655673935;8015.599220038975;8021.919780802117;8022.719204827803;8038.115807261197;8050.879236811453;4299.871003869889;4304.225239456928;4327.242732521796;4333.090051089306;4335.783210839445;3956.149427873021;3980.840766369313;3988.8603898863403;3993.520777506718;3994.400839874042;3075.815451072943;3114.2214446388402;3239.6598357172156;3283.540304357392;3333.749968752353;1031.1080915008613;1033.039273475675;1040.3341861208833;1041.5052849896238;1042.525650828871;1020.3469779341227;1021.1167340250778;1076.2573824061528;1158.5134243617701;1335.9465621375036;6399.200099987502;6428.646424446701;6435.74257029723;6440.4847612190915;6452.193475815523;1178.6640807369859;1179.6991767099335;1196.186593116689;1206.1014544164477;1216.1730023584048;5230.555402790729;5290.100682883919;5312.787488500494;5325.786968521215;5329.333833270841;7734.1492435832015;8101.959490202511;8103.4732742372735;8154;8158.796030099295;7927.286544211049;7958.761237162895;8014.879776803353;8041.678332866737;8124.5937703114605;6390.712417941204;6503.154589903283;6589.53873228879;6649.534532582769;6713.865722685519;6481.189851268591;6484.1894763154605;6489.123968264224;6497;6511.674416279262;7318.414526837947;7522.097348318237;7573.015507983927;7573.697052118074;7575.24247575238;7548.584827834522;7675.654595543102;7680.3471704905705;7682.615869206629;7695.23047695226;5936.406359364202;5988.191594134736;5994.430529099728;5998.940010599838;6009.579329446897;6488.416042556192;6668.66656667155;6679.56582822115;6690.431313338226;6698.5980841149685;6136.938630613637;6147.96926015385;6158;6184.288806787097;6351.142595749515;6215.81352559424;6235.594686345373;6248.250209974651;6261.139710641298;6329.651869147241;6124.755009799558;6130.233720784902;6225.066240064027;6225.750969961151;6246.500279977682;5812.33158186797;5899.528037756883;5904.0553511437965;5920.674362910081;5922.644641321534;5904.114382842608;5951.434613711691;5958.374370691015;5968.253968253968;5981.282246130492 20:08:11 INFO - PROCESS | 11497 | |4;prototype.html;327.2146847565842;327.7902142628718;330.35745475051004;336.7827751100541;337.8023856044214;5996.190514280571;6001.3698561651;6006.8798624027495;6018.037114061751;6023.608465449748;5669.489745922866;5712.086066229404;5801.506871915893;5843.941560584393;5957.672328021957;4477.283634618461;4517.616002639779;4519.412476378075;4521.389612402333;4521.819127234907;4337.54455782143;4519.751413672247;4535.818567257305;4536.387587675671;4537.954620453786;4362.498312694049;4432.268675668511;4500.032493014001;4506.098780243948;4518.774061296938;4476.216662084138;4503.076869241798;4508.549145085498;4517.751523666214;4520.841770538015;3996.900077498057;4001.2197621463824;4009.7594144351433;4020.0954785173394;4024.054347228399;5560.943420750044;5664;5677.091665333527;5682.772689092431;5685.1756495307945;5339.652922560022;5340.225667278261;5341.145416733343;5341.252224688546;5345.1447768356875;6288;6297.716602752841;6304.306526282106;6304.401081897213;6307.306196318401;4478.350639157336;4481.686281960264;4482.462104547475;4483.439570053743;4490.932636010462;6360.204974378203;6501.512386571026;6530.346965303432;6542.869142617169;6592.439642630382;4390.648748100144;4455.376247325312;4459.643228541709;4460.1525710114975;4465.754383508874;4512.571305725951;4513.323001549728;4520.52534483881;4526.592606665416;4529.207388706963;5243.868903277372;5244.213367994755;5245.973770131125;5250.2411692082815;5251.973740131275;6123.203983482119;6293.653849038255;6303.464205542488;6307.5269354798575;6345.206849143857;1638.2382192280409;1656.7763351947333;1656.942007029748;1658.2040620502225;1658.4195531564098;1119.5465836336298;1128.368113856243;1130.598637483698;1140.5152810055692;1152.1071169843437;6070;6075.939240607626;6087.969560152171;6090.482309003784;6096.908546371808;6518.054882042172;6522.673866306761;6526.086347911296;6531;6531.934680653228;5893.793717219876;5965.522758179335;6045.093236014545;6051.213342265477;6092.116643086728;3508.386032444312;3514.9121271967892;3538.168530395355;3539.3629146753833;3545.3618348697482;6835.487338449636;6841.144856892888;6848.7260509580055;6851.246362900077;6859.519833611599;6604.240512341143;6754.5947243165565;6755.054292399068;6764;6767.086443330186;6840.042394064835;6850.828729281709;6857.897131543031;6861.897071543931;6864.279250678706;6489.513286503626;6552.246491653521;6552.6068435894;6563.442107420923;6563.803085907431;6322.272938612118;6497.18785151856;6498.252700939453;6500;6513.15329007245;6860.622665753232;6864.965675171592;6871.209810871814;6875.759348422781;6877.58734475913;4528.728276303433;4529.162105010583;4529.932051019171;4538.591526762607;4539.568740969603;6381.712822923072;6552.213734351908;6557.836054098495;6572.737090516517;6583.967080164569;6390.360963903759;6396.840078997876;6398.488120950406;6398.71205795731;6406.455451286506;6388.616682999035;6390.073439351361;6390.13733146038;6393.552451328363;6397.616143031433;6149.385061493815;6238.968805155945;6277.340879207617;6285.182926219562;6288.905666414916;6423.357664233539;6425.357464253537;6430.967845160744;6431.1317972073175;6440.066190402272;6284.968575157095;6285.842853928689;6286;6292.056191571118;6294.71673774672 20:08:11 INFO - PROCESS | 11497 | |5;yui.html;710.2294010998066;800.8478389106069;818.7666515043214;829.5686243153559;841.486693117198;13227.470901163953;13365.064445488819;13443.395047222873;13454.461821527128;13470.3264836758;12454.377281135952;12908.225506469618;12924.418401171946;12937.935310323459;12939.741205175915;671.3890359772608;679.8912174052152;685.5612408058846;811.0348685064783;825.8100636853527;805.2551389964289;819.4182130687219;821.0434843407453;824.3734761581211;826.1985873702499;856.9143085691412;857.4598003257938;858.7080392666492;859.0250066174874;859.5186695450568;699.7550857199965;700.6146619359357;836.8159005018947;856.2892798976866;857.1214505132227;630.1587380846576;631.8041407163794;632.0613888375758;633.8035209085152;634.8317695810567;12963.935180324132;12993.87006129936;13105.344732763419;13120.409581568756;13136;11622.59320923772;11876.703082423008;12169;12288.078394120388;12518.06114541404;9883.209343252594;9903.45530995795;9980.800383992351;10155.390676559357;10179.287449878511;3575.1598374382;3628.8911332660064;3635.2729454109285;3643.0710168907026;3644.599094099647;46167.76916115431;46621.53378466206;47043.05913881737;48000.51999480031;48249.27626085612;9702.466364350028;9723.562439690231;9817.263705222136;9824.754381140387;9834.606615735434;17339.739903901453;17604.207810648553;17621.7356739649;17631.382901598638;17676;7012.403945664676;7195.496315257882;7234.674439650228;7320.267973202637;7438.66526006331;4099.938500922489;4175.958240417557;4192.098698779777;4213.852515161954;4217.219814334358;3060.525618529087;3075.4464196444405;3085.8148511088957;3086.6141732283463;3100.023492599824;550.204953841703;564.7599770097692;565.1438071321951;570.891530609183;579.6724850459477;556.9192467092249;661.2395744893315;683.7162577530269;702.5749421599961;706.6219572528776;7760.495567788075;8030.9196908031345;8043.994500687414;8127.552984585786;8347.165283471604;592.2337296388741;688.8036909480874;704.5772536478174;708.4049398505281;719.1909102259957;3620.1854582719207;3923.7841918694176;3923.7841918694744;3977.244323578511;4045.8786236412957;52952;52984.47015529795;53344.46655533473;53482;53621.73189134029;46874.531254687696;47330;50263.74868125709;50898;51160.488395116314;42852.785736071746;44590;45029.774851125534;45038.549614503434;45149.548504515195;8053;8191.467554608931;8506;8540.786480337792;8600.440971336842;33462;33863.49204761881;34094;34208.315833683686;34235;40136.799316003235;43766.124677505635;44219.33670995002;44355;44376;10090.747731306776;10617.734556636145;10962.177836662442;11050.620868967279;11261.831072533754;11919.821202681793;12087.39563021863;12237.571684990982;12282.14025018276;12528.123031387715;10102.141317988053;10622.681319560426;10665.786684266426;10677.412742298937;10897.945510272399;10590.16934077531;10645.627403040857;10904.34573925567;10984.505697243483;10986.725331866768;10767;10897.56409743633;11024.007839294502;11157.330560166416;11255.212135150461;9272.953635231781;9364.448561269222;9625.807483850424;9687.854682179914;9775.755606109904;8411.747647570583;8606.741797746077;8632.78418039554;9160.946491153336;9191.172794448532 20:08:11 INFO - PROCESS | 11497 | __end_tp_report 20:08:11 INFO - PROCESS | 11497 | __start_cc_report 20:08:11 INFO - PROCESS | 11497 | _x_x_mozilla_cycle_collect,1569 20:08:11 INFO - PROCESS | 11497 | __end_cc_report 20:08:11 INFO - PROCESS | 11497 | __startTimestamp1451448491259__endTimestamp 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | ------- Summary: start ------- 20:08:11 INFO - PROCESS | 11497 | Number of tests: 6 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | [#0] dojo.html Cycles:165 Average:5099.77 Median:5263.05 stddev:537.78 (10.2%) stddev-sans-first:515.30 20:08:11 INFO - PROCESS | 11497 | Values: 3069.3 3100.4 3157.9 3162.2 3174.1 5024.7 5119.0 5154.0 5179.2 5205.0 5030.2 5094.3 5173.0 5203.3 5215.4 4527.7 4667.1 4680.1 4746.4 4784.2 4605.8 4735.9 4749.6 4756.6 4865.2 4626.7 4713.3 4729.8 4731.9 4760.4 4690.8 4706.7 4717.2 4739.4 4740.1 4538.2 4622.0 4679.3 4695.7 4731.2 4959.3 5029.1 5044.0 5069.9 5086.0 5460.5 5468.6 5469.5 5473.1 5474.0 5392.7 5519.0 5538.0 5539.9 5587.7 5112.3 5125.4 5138.8 5159.7 5202.6 5564.0 5567.8 5567.9 5577.1 5616.1 5297.3 5348.5 5355.8 5361.9 5382.3 5377.8 5422.7 5433.5 5490.8 5520.5 5450.3 5451.6 5482.9 5487.3 5492.5 5347.5 5455.1 5473.5 5477.9 5524.3 4225.7 4251.6 4277.8 4280.9 4288.8 3804.9 3817.7 3825.0 3845.5 3847.6 5127.1 5127.4 5128.6 5128.8 5134.8 5372.3 5417.4 5460.6 5461.6 5494.3 5170.6 5189.3 5191.9 5196.2 5199.9 4805.1 4814.3 4815.1 4820.7 4858.7 5438.5 5601.1 5601.4 5640.1 5736.6 5495.6 5497.0 5500.6 5502.3 5503.8 5676.6 5678.7 5694.5 5706.4 5712.0 5318.0 5404.8 5422.7 5498.9 5548.2 5438.6 5468.1 5470.5 5491.5 5491.8 5259.0 5354.7 5360.7 5363.8 5412.8 5246.5 5289.7 5295.1 5307.8 5310.7 5233.1 5236.7 5238.2 5243.8 5247.6 5309.2 5320.7 5343.7 5344.1 5422.0 5263.1 5269.5 5272.9 5301.0 5317.0 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | [#1] ext.html Cycles:180 Average:42947.37 Median:33166.92 stddev:67808.15 (204.4%) stddev-sans-first:67923.63 20:08:11 INFO - PROCESS | 11497 | Values: 546.7 567.0 573.8 577.3 580.7 28437.0 36177.0 36809.8 36874.1 36885.8 40132.2 40659.0 40749.0 40801.0 40869.0 7307.0 7399.7 8528.7 8708.7 8709.0 10125.0 10319.5 10327.1 10327.7 10332.9 10103.8 10210.2 10215.0 10216.8 10216.9 7517.0 7712.4 9970.5 10194.1 10397.4 9903.1 9963.1 9994.5 10026.5 10030.5 36758.8 36927.8 37001.4 37237.0 37307.8 3300.6 3356.4 3514.9 3969.6 3995.4 30322.7 30904.2 30946.4 31235.5 31411.0 3919.7 3929.5 4003.9 4034.5 4116.3 264754.0 266805.0 268515.0 268616.0 268958.0 53089.5 54199.7 60082.0 61718.7 63608.4 54061.5 54077.0 54448.5 54484.5 54484.7 14523.0 14542.3 14582.7 14583.5 14714.3 10975.2 10984.5 11041.9 11120.7 11315.1 19593.0 19809.7 19863.3 19925.7 19927.8 7151.7 7346.3 7409.4 7435.2 7467.4 948.0 970.2 1008.1 1032.2 1048.0 28703.1 28989.9 29317.0 29521.0 29850.4 999.9 1019.1 1038.4 1041.6 1125.6 14561.4 14579.6 14606.3 14845.2 14888.7 303473.0 306233.0 307001.0 307661.0 307761.0 48913.5 49733.0 51053.5 52077.0 52416.2 1332.1 1340.6 1343.3 1344.1 1350.4 25642.4 25980.6 26383.6 27925.0 28029.3 43080.4 43938.3 44014.1 48760.0 49928.8 192578.0 193668.0 193948.0 194487.0 194538.0 30250.7 30476.9 30589.4 30609.8 30638.4 42501.8 42696.6 42991.6 43760.0 43882.0 36528.3 37207.3 37592.0 38025.6 38292.2 37194.4 37273.3 38127.4 38264.8 38559.4 33005.7 33328.2 33473.7 35290.0 36954.4 32191.5 32989.0 33364.3 33397.8 33476.7 25204.0 25400.6 25477.4 25504.5 25573.0 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | [#2] jquery.html Cycles:180 Average:29545.53 Median:17854.35 stddev:94598.59 (529.8%) stddev-sans-first:94838.56 20:08:11 INFO - PROCESS | 11497 | Values: 348.1 350.4 353.4 353.7 354.7 13400.3 13733.4 15901.4 15963.8 16315.3 15655.8 15828.7 17037.6 17129.4 17183.8 4687.9 4858.4 4860.7 4862.5 4862.8 3702.0 3815.7 4864.5 5256.3 5450.0 5414.9 5437.5 5443.3 5450.6 5463.2 5089.2 5269.2 5275.0 5275.6 5391.7 5087.1 5088.4 5088.8 5090.5 5090.6 13120.0 14175.6 19401.0 20652.6 20740.9 2055.9 2066.4 2087.7 2159.4 2161.1 9480.0 9731.2 9750.3 10793.9 13008.7 1793.7 1843.3 1854.3 1874.0 1929.4 55022.4 57437.1 58201.7 58228.7 61169.4 10043.3 10227.5 10230.4 10294.1 10394.0 13361.3 13379.7 13385.1 13393.3 13394.8 7423.0 7589.1 7609.7 7650.7 7657.7 7066.2 7155.9 7367.5 7391.0 7443.8 4413.6 4451.8 4477.1 4518.9 4523.7 1728.4 1782.7 1783.1 1795.8 1820.6 851.4 908.8 948.0 985.7 1037.5 14314.2 15619.0 16107.4 16576.8 16678.2 914.7 943.1 948.6 968.6 994.0 8860.7 8927.3 9075.0 9076.4 9221.1 571815.0 572441.0 578333.0 584561.0 589951.0 76338.0 76802.0 77192.6 79640.6 80893.6 1035.3 1055.8 1058.2 1063.9 1087.9 14990.5 15256.5 15344.9 15555.0 15643.6 34120.8 34257.3 35120.3 35354.0 35462.8 43672.8 44871.1 45264.5 45672.8 46357.3 8744.9 9549.6 9565.5 9571.4 9575.6 13526.3 16392.1 16519.7 16636.3 17017.6 11978.2 13531.9 13978.7 14332.4 14466.3 13684.1 14132.2 14156.0 14286.7 14415.6 13732.6 13776.4 13861.3 14309.6 14446.1 9407.0 9622.1 9624.2 9634.4 9834.5 13417.3 13464.7 13672.5 13863.7 14719.5 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | [#3] mootools.html Cycles:180 Average:4862.34 Median:5984.74 stddev:2428.52 (40.6%) stddev-sans-first:2420.39 20:08:11 INFO - PROCESS | 11497 | Values: 1278.2 1422.7 1428.0 1539.5 1729.0 6047.6 6679.1 6786.2 6788.1 6805.1 6603.0 6774.8 6775.6 6779.3 6784.0 1841.9 1870.8 2037.1 2078.8 2115.4 2122.7 2129.6 2130.1 2130.6 2134.6 2074.5 2080.5 2125.5 2128.4 2132.1 2090.5 2091.5 2097.1 2103.5 2115.8 2076.4 2086.6 2089.0 2094.2 2099.4 6865.0 6911.4 6922.0 6922.9 6934.4 4134.3 4194.9 4231.6 4236.9 4238.3 2773.3 2838.8 2871.1 2872.0 2887.8 847.3 872.8 876.2 923.2 933.1 9023.2 9035.5 9037.7 9050.1 9070.3 3797.6 3808.7 3858.1 3871.7 3880.8 8015.6 8021.9 8022.7 8038.1 8050.9 4299.9 4304.2 4327.2 4333.1 4335.8 3956.1 3980.8 3988.9 3993.5 3994.4 3075.8 3114.2 3239.7 3283.5 3333.7 1031.1 1033.0 1040.3 1041.5 1042.5 1020.3 1021.1 1076.3 1158.5 1335.9 6399.2 6428.6 6435.7 6440.5 6452.2 1178.7 1179.7 1196.2 1206.1 1216.2 5230.6 5290.1 5312.8 5325.8 5329.3 7734.1 8102.0 8103.5 8154.0 8158.8 7927.3 7958.8 8014.9 8041.7 8124.6 6390.7 6503.2 6589.5 6649.5 6713.9 6481.2 6484.2 6489.1 6497.0 6511.7 7318.4 7522.1 7573.0 7573.7 7575.2 7548.6 7675.7 7680.3 7682.6 7695.2 5936.4 5988.2 5994.4 5998.9 6009.6 6488.4 6668.7 6679.6 6690.4 6698.6 6136.9 6148.0 6158.0 6184.3 6351.1 6215.8 6235.6 6248.3 6261.1 6329.7 6124.8 6130.2 6225.1 6225.8 6246.5 5812.3 5899.5 5904.1 5920.7 5922.6 5904.1 5951.4 5958.4 5968.3 5981.3 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | [#4] prototype.html Cycles:180 Average:5304.57 Median:6020.82 stddev:1599.39 (26.6%) stddev-sans-first:1559.64 20:08:11 INFO - PROCESS | 11497 | Values: 327.2 327.8 330.4 336.8 337.8 5996.2 6001.4 6006.9 6018.0 6023.6 5669.5 5712.1 5801.5 5843.9 5957.7 4477.3 4517.6 4519.4 4521.4 4521.8 4337.5 4519.8 4535.8 4536.4 4538.0 4362.5 4432.3 4500.0 4506.1 4518.8 4476.2 4503.1 4508.5 4517.8 4520.8 3996.9 4001.2 4009.8 4020.1 4024.1 5560.9 5664.0 5677.1 5682.8 5685.2 5339.7 5340.2 5341.1 5341.3 5345.1 6288.0 6297.7 6304.3 6304.4 6307.3 4478.4 4481.7 4482.5 4483.4 4490.9 6360.2 6501.5 6530.3 6542.9 6592.4 4390.6 4455.4 4459.6 4460.2 4465.8 4512.6 4513.3 4520.5 4526.6 4529.2 5243.9 5244.2 5246.0 5250.2 5252.0 6123.2 6293.7 6303.5 6307.5 6345.2 1638.2 1656.8 1656.9 1658.2 1658.4 1119.5 1128.4 1130.6 1140.5 1152.1 6070.0 6075.9 6088.0 6090.5 6096.9 6518.1 6522.7 6526.1 6531.0 6531.9 5893.8 5965.5 6045.1 6051.2 6092.1 3508.4 3514.9 3538.2 3539.4 3545.4 6835.5 6841.1 6848.7 6851.2 6859.5 6604.2 6754.6 6755.1 6764.0 6767.1 6840.0 6850.8 6857.9 6861.9 6864.3 6489.5 6552.2 6552.6 6563.4 6563.8 6322.3 6497.2 6498.3 6500.0 6513.2 6860.6 6865.0 6871.2 6875.8 6877.6 4528.7 4529.2 4529.9 4538.6 4539.6 6381.7 6552.2 6557.8 6572.7 6584.0 6390.4 6396.8 6398.5 6398.7 6406.5 6388.6 6390.1 6390.1 6393.6 6397.6 6149.4 6239.0 6277.3 6285.2 6288.9 6423.4 6425.4 6431.0 6431.1 6440.1 6285.0 6285.8 6286.0 6292.1 6294.7 20:08:11 INFO - PROCESS | 11497 | 20:08:11 INFO - PROCESS | 11497 | [#5] yui.html Cycles:180 Average:13312.08 Median:47186.53 stddev:15267.20 (32.4%) stddev-sans-first:15280.70 20:08:11 INFO - PROCESS | 11497 | Values: 710.2 800.8 818.8 829.6 841.5 13227.5 13365.1 13443.4 13454.5 13470.3 12454.4 12908.2 12924.4 12937.9 12939.7 671.4 679.9 685.6 811.0 825.8 805.3 819.4 821.0 824.4 826.2 856.9 857.5 858.7 859.0 859.5 699.8 700.6 836.8 856.3 857.1 630.2 631.8 632.1 633.8 634.8 12963.9 12993.9 13105.3 13120.4 13136.0 11622.6 11876.7 12169.0 12288.1 12518.1 9883.2 9903.5 9980.8 10155.4 10179.3 3575.2 3628.9 3635.3 3643.1 3644.6 46167.8 46621.5 47043.1 48000.5 48249.3 9702.5 9723.6 9817.3 9824.8 9834.6 17339.7 17604.2 17621.7 17631.4 17676.0 7012.4 7195.5 7234.7 7320.3 7438.7 4099.9 4176.0 4192.1 4213.9 4217.2 3060.5 3075.4 3085.8 3086.6 3100.0 550.2 564.8 565.1 570.9 579.7 556.9 661.2 683.7 702.6 706.6 7760.5 8030.9 8044.0 8127.6 8347.2 592.2 688.8 704.6 708.4 719.2 3620.2 3923.8 3923.8 3977.2 4045.9 52952.0 52984.5 53344.5 53482.0 53621.7 46874.5 47330.0 50263.7 50898.0 51160.5 42852.8 44590.0 45029.8 45038.5 45149.5 8053.0 8191.5 8506.0 8540.8 8600.4 33462.0 33863.5 34094.0 34208.3 34235.0 40136.8 43766.1 44219.3 44355.0 44376.0 10090.7 10617.7 10962.2 11050.6 11261.8 11919.8 12087.4 12237.6 12282.1 12528.1 10102.1 10622.7 10665.8 10677.4 10897.9 10590.2 10645.6 10904.3 10984.5 10986.7 10767.0 10897.6 11024.0 11157.3 11255.2 9273.0 9364.4 9625.8 9687.9 9775.8 8411.7 8606.7 8632.8 9160.9 9191.2 20:08:11 INFO - PROCESS | 11497 | -------- Summary: end -------- 20:08:11 INFO - PROCESS | 11497 | 20:08:12 INFO - TEST-INFO | 11497: exit 0 20:08:12 INFO - TEST-OK | dromaeo_css | took 1112372ms 20:08:12 INFO - TEST-START | kraken 20:08:12 INFO - operating with platform_type : linux_ 20:08:12 INFO - Initialising browser for kraken test... 20:08:12 INFO - TEST-INFO | started process 11688 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoEwKr0/profile http://localhost:51416/getInfo.html) 20:08:15 INFO - PROCESS | 11688 | __metrics Screen width/height:1600/1200 20:08:15 INFO - PROCESS | 11688 | colorDepth:24 20:08:15 INFO - PROCESS | 11688 | Browser inner width/height: 1024/697 20:08:15 INFO - PROCESS | 11688 | __metrics 20:08:15 INFO - PROCESS | 11688 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:08:16 INFO - PROCESS | 11688 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:08:16 INFO - TEST-INFO | 11688: exit 0 20:08:16 INFO - Browser initialized. 20:08:16 INFO - Running cycle 1/1 for kraken test... 20:08:16 INFO - TEST-INFO | started process 11771 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoEwKr0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:28 INFO - PROCESS | 11771 | RSS: Main: 148807680 20:08:28 INFO - PROCESS | 11771 | 20:08:31 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-beat-detection) 20:08:31 INFO - PROCESS | 11771 | RSS: Main: 185647104 20:08:31 INFO - PROCESS | 11771 | 20:08:34 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-dft) 20:08:35 INFO - PROCESS | 11771 | RSS: Main: 175185920 20:08:35 INFO - PROCESS | 11771 | 20:08:37 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-fft) 20:08:38 INFO - PROCESS | 11771 | RSS: Main: 161771520 20:08:38 INFO - PROCESS | 11771 | 20:08:40 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-oscillator) 20:08:41 INFO - PROCESS | 11771 | RSS: Main: 162844672 20:08:41 INFO - PROCESS | 11771 | 20:08:43 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:08:43 INFO - PROCESS | 11771 | RSS: Main: 165363712 20:08:43 INFO - PROCESS | 11771 | 20:08:46 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51416/tests/kraken/driver.html?testName=imaging-darkroom) 20:08:47 INFO - PROCESS | 11771 | RSS: Main: 165515264 20:08:47 INFO - PROCESS | 11771 | 20:08:50 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51416/tests/kraken/driver.html?testName=imaging-desaturate) 20:08:51 INFO - PROCESS | 11771 | RSS: Main: 166404096 20:08:51 INFO - PROCESS | 11771 | 20:08:54 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51416/tests/kraken/driver.html?testName=json-parse-financial) 20:08:54 INFO - PROCESS | 11771 | RSS: Main: 166813696 20:08:54 INFO - PROCESS | 11771 | 20:08:56 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:08:56 INFO - PROCESS | 11771 | RSS: Main: 176930816 20:08:56 INFO - PROCESS | 11771 | 20:08:58 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:08:59 INFO - PROCESS | 11771 | RSS: Main: 174714880 20:08:59 INFO - PROCESS | 11771 | 20:09:01 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:09:01 INFO - PROCESS | 11771 | RSS: Main: 187371520 20:09:01 INFO - PROCESS | 11771 | 20:09:04 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:09:04 INFO - PROCESS | 11771 | RSS: Main: 193576960 20:09:04 INFO - PROCESS | 11771 | 20:09:07 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:09:07 INFO - PROCESS | 11771 | RSS: Main: 189587456 20:09:07 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51416/tests/kraken/driver.html?testName=ai-astar) 20:09:09 INFO - PROCESS | 11771 | RSS: Main: 248045568 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | __start_tp_report 20:09:09 INFO - PROCESS | 11771 | _x_x_mozilla_page_load 20:09:09 INFO - PROCESS | 11771 | _x_x_mozilla_page_load_details 20:09:09 INFO - PROCESS | 11771 | |i|pagename|runs| 20:09:09 INFO - PROCESS | 11771 | |0;ai-astar;108;110;106;110;112;110;99;111;112;101 20:09:09 INFO - PROCESS | 11771 | |1;audio-beat-detection;147;125;152;163;127;159;150;131;168;127 20:09:09 INFO - PROCESS | 11771 | |2;audio-dft;160;160;160;160;161;161;160;159;161;160 20:09:09 INFO - PROCESS | 11771 | |3;audio-fft;72;75;83;92;71;72;74;111;91;71 20:09:09 INFO - PROCESS | 11771 | |4;audio-oscillator;96;95;139;96;97;96;150;95;96;139 20:09:09 INFO - PROCESS | 11771 | |5;imaging-gaussian-blur;109;109;109;110;110;110;109;110;109;109 20:09:09 INFO - PROCESS | 11771 | |6;imaging-darkroom;146;145;145;145;146;146;146;145;146;146 20:09:09 INFO - PROCESS | 11771 | |7;imaging-desaturate;95;95;95;95;96;96;95;96;95;95 20:09:09 INFO - PROCESS | 11771 | |8;json-parse-financial;59;57;59;58;60;58;60;68;56;57 20:09:09 INFO - PROCESS | 11771 | |9;json-stringify-tinderbox;68;69;69;68;68;68;68;69;68;68 20:09:09 INFO - PROCESS | 11771 | |10;stanford-crypto-aes;92;86;87;87;87;87;89;86;88;87 20:09:09 INFO - PROCESS | 11771 | |11;stanford-crypto-ccm;120;116;119;113;114;116;126;119;126;119 20:09:09 INFO - PROCESS | 11771 | |12;stanford-crypto-pbkdf2;142;138;149;150;148;140;150;150;149;138 20:09:09 INFO - PROCESS | 11771 | |13;stanford-crypto-sha256-iterative;68;68;69;68;70;66;67;67;68;69 20:09:09 INFO - PROCESS | 11771 | __end_tp_report 20:09:09 INFO - PROCESS | 11771 | __start_cc_report 20:09:09 INFO - PROCESS | 11771 | _x_x_mozilla_cycle_collect,927 20:09:09 INFO - PROCESS | 11771 | __end_cc_report 20:09:09 INFO - PROCESS | 11771 | __startTimestamp1451448549791__endTimestamp 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | ------- Summary: start ------- 20:09:09 INFO - PROCESS | 11771 | Number of tests: 14 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.50 stddev:4.56 (4.1%) stddev-sans-first:4.83 20:09:09 INFO - PROCESS | 11771 | Values: 108.0 110.0 106.0 110.0 112.0 110.0 99.0 111.0 112.0 101.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:151.00 stddev:16.23 (10.7%) stddev-sans-first:17.20 20:09:09 INFO - PROCESS | 11771 | Values: 147.0 125.0 152.0 163.0 127.0 159.0 150.0 131.0 168.0 127.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:09:09 INFO - PROCESS | 11771 | Values: 160.0 160.0 160.0 160.0 161.0 161.0 160.0 159.0 161.0 160.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#3] audio-fft Cycles:10 Average:81.20 Median:74.50 stddev:13.21 (17.7%) stddev-sans-first:13.59 20:09:09 INFO - PROCESS | 11771 | Values: 72.0 75.0 83.0 92.0 71.0 72.0 74.0 111.0 91.0 71.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:22.82 (23.8%) stddev-sans-first:23.64 20:09:09 INFO - PROCESS | 11771 | Values: 96.0 95.0 139.0 96.0 97.0 96.0 150.0 95.0 96.0 139.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:09:09 INFO - PROCESS | 11771 | Values: 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:09:09 INFO - PROCESS | 11771 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:09:09 INFO - PROCESS | 11771 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:3.36 (5.7%) stddev-sans-first:3.56 20:09:09 INFO - PROCESS | 11771 | Values: 59.0 57.0 59.0 58.0 60.0 58.0 60.0 68.0 56.0 57.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 20:09:09 INFO - PROCESS | 11771 | Values: 68.0 69.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.00 stddev:1.78 (2.0%) stddev-sans-first:0.93 20:09:09 INFO - PROCESS | 11771 | Values: 92.0 86.0 87.0 87.0 87.0 87.0 89.0 86.0 88.0 87.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:119.00 stddev:4.44 (3.7%) stddev-sans-first:4.69 20:09:09 INFO - PROCESS | 11771 | Values: 120.0 116.0 119.0 113.0 114.0 116.0 126.0 119.0 126.0 119.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:149.00 stddev:5.23 (3.5%) stddev-sans-first:5.40 20:09:09 INFO - PROCESS | 11771 | Values: 142.0 138.0 149.0 150.0 148.0 140.0 150.0 150.0 149.0 138.0 20:09:09 INFO - PROCESS | 11771 | 20:09:09 INFO - PROCESS | 11771 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 20:09:09 INFO - PROCESS | 11771 | Values: 68.0 68.0 69.0 68.0 70.0 66.0 67.0 67.0 68.0 69.0 20:09:09 INFO - PROCESS | 11771 | -------- Summary: end -------- 20:09:09 INFO - PROCESS | 11771 | 20:09:10 INFO - TEST-INFO | 11771: exit 0 20:09:10 INFO - TEST-OK | kraken | took 58675ms 20:09:10 INFO - TEST-START | v8_7 20:09:10 INFO - operating with platform_type : linux_ 20:09:10 INFO - Initialising browser for v8_7 test... 20:09:10 INFO - TEST-INFO | started process 12020 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9QgciM/profile http://localhost:51416/getInfo.html) 20:09:14 INFO - PROCESS | 12020 | __metrics Screen width/height:1600/1200 20:09:14 INFO - PROCESS | 12020 | colorDepth:24 20:09:14 INFO - PROCESS | 12020 | Browser inner width/height: 1024/697 20:09:14 INFO - PROCESS | 12020 | __metrics 20:09:14 INFO - PROCESS | 12020 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:09:14 INFO - PROCESS | 12020 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:15 INFO - TEST-INFO | 12020: exit 0 20:09:15 INFO - Browser initialized. 20:09:15 INFO - Running cycle 1/1 for v8_7 test... 20:09:15 INFO - TEST-INFO | started process 12106 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9QgciM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:27 INFO - PROCESS | 12106 | RSS: Main: 149712896 20:09:27 INFO - PROCESS | 12106 | 20:09:48 INFO - PROCESS | 12106 | Cycle 1(1): loaded http://localhost:51416/tests/v8_7/run.html (next: http://localhost:51416/tests/v8_7/run.html) 20:09:49 INFO - PROCESS | 12106 | RSS: Main: 631132160 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | __start_tp_report 20:09:49 INFO - PROCESS | 12106 | _x_x_mozilla_page_load 20:09:49 INFO - PROCESS | 12106 | _x_x_mozilla_page_load_details 20:09:49 INFO - PROCESS | 12106 | |i|pagename|runs| 20:09:49 INFO - PROCESS | 12106 | |0;Richards;167.36401673640168 20:09:49 INFO - PROCESS | 12106 | |1;DeltaBlue;191.16803670426305 20:09:49 INFO - PROCESS | 12106 | |2;Encrypt;280.1120448179272 20:09:49 INFO - PROCESS | 12106 | |3;Decrypt;5246.073298429319 20:09:49 INFO - PROCESS | 12106 | |4;RayTrace;2036.6598778004072 20:09:49 INFO - PROCESS | 12106 | |5;Earley;792.3930269413629 20:09:49 INFO - PROCESS | 12106 | |6;Boyer;12268.292682926829 20:09:49 INFO - PROCESS | 12106 | |7;RegExp;26256.410256410258 20:09:49 INFO - PROCESS | 12106 | |8;Splay;657.1609632446134 20:09:49 INFO - PROCESS | 12106 | |9;NavierStokes;4835.748792270531 20:09:49 INFO - PROCESS | 12106 | __end_tp_report 20:09:49 INFO - PROCESS | 12106 | __startTimestamp1451448589193__endTimestamp 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | ------- Summary: start ------- 20:09:49 INFO - PROCESS | 12106 | Number of tests: 10 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 167.4 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#1] DeltaBlue Cycles:1 Average:191.17 Median:191.17 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 191.2 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 280.1 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 5246.1 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#4] RayTrace Cycles:1 Average:2036.66 Median:2036.66 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 2036.7 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 792.4 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 12268.3 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 26256.4 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#8] Splay Cycles:1 Average:657.16 Median:657.16 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 657.2 20:09:49 INFO - PROCESS | 12106 | 20:09:49 INFO - PROCESS | 12106 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:09:49 INFO - PROCESS | 12106 | Values: 4835.7 20:09:49 INFO - PROCESS | 12106 | -------- Summary: end -------- 20:09:49 INFO - PROCESS | 12106 | 20:09:50 INFO - TEST-INFO | 12106: exit 0 20:09:50 INFO - TEST-OK | v8_7 | took 39375ms 20:09:50 INFO - SUITE-END | took 1210s 20:09:50 INFO - Completed test suite (00:20:10) 20:09:50 INFO - Working with test: dromaeo_css 20:09:50 INFO - Generating results file: dromaeo_css 20:09:50 INFO - Working with test: kraken 20:09:50 INFO - Generating results file: kraken 20:09:50 INFO - javascript benchmark 20:09:50 INFO - Working with test: v8_7 20:09:50 INFO - Generating results file: v8_7 20:09:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:09:50 INFO - process_Request line: dromaeo_css 6763.89 graph.html#tests=[[72,64,35]] 20:09:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:50 INFO - process_Request line: kraken 1501.70 graph.html#tests=[[232,64,35]] 20:09:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:50 INFO - process_Request line: v8_7 19516.26 graph.html#tests=[[230,64,35]] 20:09:50 INFO - RETURN: dromaeo_css: 6763.89 20:09:50 INFO - RETURN: kraken: 1501.70 20:09:50 INFO - RETURN: v8_7: 19516.26 20:09:50 INFO - javascript benchmark 20:09:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3069.324748555318, 3100.3954228925368, 3157.8894738684153, 3162.177833763221, 3174.1112488503218, 5024.698518088917, 5119.001794650045, 5153.974230128849, 5179.19722443021, 5204.973975130124, 5030.195168772997, 5094.261332106842, 5172.965406918622, 5203.2975548300965, 5215.400228973669, 4527.660425468087, 4667.13657973276, 4680.063987202565, 4746.359241502388, 4784.234522476405, 4605.838795642153, 4735.90528189436, 4749.6200303975775, 4756.619470442356, 4865.221564549673, 4626.65300102492, 4713.316569097462, 4729.810807567693, 4731.881702957437, 4760.3573517575205, 4690.835820746258, 4706.74112923789, 4717.198076327033, 4739.4075740532435, 4740.051989602059, 4538.183127037132, 4622.0, 4679.298105284201, 4695.741734204617, 4731.1720448921305, 4959.256111583255, 5029.119904016782, 5044.041632089891, 5069.949300506984, 5085.974570127126, 5460.481254280837, 5468.644538105011, 5469.480399362054, 5473.06957817168, 5473.972630136864, 5392.703401312965, 5519.0, 5538.0, 5539.8892022159735, 5587.74855131516, 5112.335396398445, 5125.359330083739, 5138.820141295037, 5159.74201289934, 5202.557782588485, 5564.026295398289, 5567.777288908398, 5567.8886422272135, 5577.05190117681, 5616.129499927518, 5297.258383826267, 5348.5186333230195, 5355.785768569292, 5361.946380536223, 5382.273393091961, 5377.838664840061, 5422.674639521641, 5433.456654334614, 5490.752916118784, 5520.475554822286, 5450.345958485007, 5451.591130665216, 5482.91775623366, 5487.341519017744, 5492.505674489315, 5347.545458635982, 5455.072637651609, 5473.534749546254, 5477.945220547823, 5524.309461317335, 4225.661947044229, 4251.553586873396, 4277.7647229402055, 4280.892977675583, 4288.807003684841, 3804.8668296609485, 3817.675497582681, 3824.961750382516, 3845.4808600839087, 3847.5960024197616, 5127.102757017507, 5127.410347809975, 5128.564072053842, 5128.8461346159675, 5134.820281290137, 5372.274742909735, 5417.4311697272005, 5460.6177567569885, 5461.644993075437, 5494.2857428534035, 5170.586353091744, 5189.273501709764, 5191.922121168185, 5196.220566914993, 5199.948000520022, 4805.063012712558, 4814.301926220678, 4815.133276010351, 4820.68665536739, 4858.732769697701, 5438.483344082306, 5601.103823388238, 5601.411851755588, 5640.097584386478, 5736.62711923732, 5495.587830912617, 5496.972515137559, 5500.559955203494, 5502.339719233558, 5503.752331145028, 5676.5742569308295, 5678.716064196691, 5694.4590263924865, 5706.400827913009, 5712.028955077563, 5318.042752304622, 5404.756785944721, 5422.701751403711, 5498.945010549844, 5548.195511650869, 5438.619296649196, 5468.0977638690765, 5470.507654310972, 5491.505764481216, 5491.835244942658, 5259.0, 5354.6787192767, 5360.70516121617, 5363.812266570651, 5412.78348866041, 5246.527812496894, 5289.68261904287, 5295.099833028471, 5307.814226502054, 5310.6813591184655, 5233.110371236975, 5236.659617124875, 5238.240455133908, 5243.790248390022, 5247.632665713363, 5309.230161626465, 5320.654157479751, 5343.7060961647485, 5344.091504444176, 5422.0, 5263.052650522943, 5269.499397557226, 5272.86817829542, 5301.0, 5317.042932272228], "unit": "score", "name": "dojo.html", "value": 5066.679863456693}, {"lowerIsBetter": false, "replicates": [546.6993153765428, 567.0133966897598, 573.796302312679, 577.3302968556476, 580.7299605683359, 28437.0, 36177.0, 36809.81595092021, 36874.07814804631, 36885.815570922176, 40132.197356052864, 40659.0, 40749.0, 40801.0, 40869.0, 7306.9770232167275, 7399.667014984312, 8528.744137675863, 8708.695195668153, 8709.042005379435, 10125.0, 10319.484025798718, 10327.122194613466, 10327.741806454824, 10332.896671033306, 10103.84844227337, 10210.183185345155, 10215.0, 10216.846747298796, 10216.948915255412, 7517.0, 7712.421568382394, 9970.501474926261, 10194.133498652624, 10397.428141452217, 9903.108720215143, 9963.103320701099, 9994.45030523321, 10026.498675066217, 10030.498475076218, 36758.816205919065, 36927.81536092302, 37001.444978325344, 37237.0, 37307.81346093279, 3300.620428650712, 3356.3622911646953, 3514.859405623772, 3969.6177312912464, 3995.380715989026, 30322.696773032207, 30904.227394315098, 30946.381072378652, 31235.531467028013, 31411.0, 3919.7326413618794, 3929.469521614574, 4003.8798836034966, 4034.45534852797, 4116.341385378355, 264754.0, 266805.0, 268515.0, 268616.0, 268958.0, 53089.46910530845, 54199.72900135474, 60082.0, 61718.69140654268, 63608.363916361166, 54061.45938540643, 54077.0, 54448.45551544513, 54484.45515544794, 54484.72757636187, 14523.0, 14542.345594448276, 14582.708345833023, 14583.489577864724, 14714.264286785618, 10975.231733778559, 10984.505697243643, 11041.889581104248, 11120.666380008613, 11315.094792416587, 19593.0, 19809.702854457195, 19863.30478433248, 19925.701114483294, 19927.800721992884, 7151.749688760972, 7346.302101300368, 7409.444291678145, 7435.219301973323, 7467.402607791364, 947.9810403791886, 970.1850445625709, 1008.0876806490138, 1032.2464600841279, 1047.984280235797, 28703.138905832857, 28989.855050725033, 29316.97390591319, 29521.0, 29850.40299194004, 999.9000099990088, 1019.0777346501428, 1038.4340534408766, 1041.6458404142477, 1125.6496514548646, 14561.417543298361, 14579.635509112357, 14606.34271457787, 14845.183514906785, 14888.70222595542, 303473.0, 306233.0, 307001.0, 307661.0, 307761.0, 48913.51086489161, 49733.0, 51053.48946510562, 52077.0, 52416.21375679292, 1332.0808642036964, 1340.6447291467769, 1343.3014832287156, 1344.0793056756154, 1350.3518311210673, 25642.358941026625, 25980.610290845274, 26383.598979678703, 27925.045246832527, 28029.29926751766, 43080.35379469373, 43938.34092488679, 44014.11971760611, 48760.0, 49928.75035624798, 192578.0, 193668.0, 193948.0, 194487.0, 194538.0, 30250.69749302479, 30476.933307334137, 30589.388212236077, 30609.846950765103, 30638.387232255674, 42501.78749106234, 42696.58427325868, 42991.57008429876, 43760.0, 43882.0, 36528.26943461169, 37207.25585488221, 37592.0, 38025.619743802206, 38292.234155317296, 37194.44208336823, 37273.25453490969, 38127.42808857814, 38264.80867595644, 38559.42160867533, 33005.66994330026, 33328.1667958303, 33473.665263348026, 35290.0, 36954.44568331423, 32191.51712724358, 32989.0, 33364.32197028089, 33397.83301083479, 33476.665233347354, 25204.0, 25400.618990715524, 25477.36306592276, 25504.489910201322, 25573.040883735674], "unit": "score", "name": "ext.html", "value": 18257.63716868779}, {"lowerIsBetter": false, "replicates": [348.1071052749697, 350.39906560249176, 353.4380335266925, 353.7276297251115, 354.69850626967076, 13400.262985535792, 13733.381997810098, 15901.363945442168, 15963.760543591841, 16315.347386104571, 15655.765163522556, 15828.683426331467, 17037.57406064849, 17129.400470983517, 17183.82816171838, 4687.859364219071, 4858.368412106422, 4860.7326597037145, 4862.465128835825, 4862.829800956967, 3702.0374702577255, 3815.7328986970924, 4864.464908860023, 5256.290400795881, 5449.972750136264, 5414.864628384302, 5437.510624043835, 5443.319585051869, 5450.56395488362, 5463.180522921554, 5089.160288552384, 5269.209618557209, 5274.97362513185, 5275.551578115884, 5391.676499410048, 5087.084324821531, 5088.4148322942965, 5088.821891233789, 5090.465501122403, 5090.643654944155, 13120.0, 14175.57473275793, 19401.0, 20652.5869482611, 20740.896295518578, 2055.9280425185048, 2066.3904148276297, 2087.7077209190725, 2159.3521943416913, 2161.146347192866, 9480.0, 9731.172850307732, 9750.26872984529, 10793.946030269877, 13008.739825203444, 1793.6681713882974, 1843.2719075965053, 1854.2860998515534, 1874.0, 1929.4308179087063, 55022.44977550213, 57437.13844292339, 58201.7089914552, 58228.70885645544, 61169.388306116816, 10043.347182433119, 10227.539760710786, 10230.386176829414, 10294.095592315445, 10394.01256880595, 13361.26513041792, 13379.732405351839, 13385.129966552144, 13393.26337051452, 13394.799078013837, 7422.960785490036, 7589.1272503662785, 7609.733659321897, 7650.693972241048, 7657.6554055066545, 7066.222715501291, 7155.856882862314, 7367.5211111277595, 7390.96304518474, 7443.776686699408, 4413.58070983256, 4451.7996690148375, 4477.104579084196, 4518.909621807546, 4523.683342166017, 1728.438257566296, 1782.6702060118919, 1783.144090836406, 1795.8473529749856, 1820.599468117012, 851.4040171879709, 908.7682640926654, 948.0, 985.6648739428485, 1037.4501514197336, 14314.212718300385, 15619.0, 16107.355705771872, 16576.83423165753, 16678.166091695366, 914.7392992996964, 943.1040511513952, 948.5968463403026, 968.5786682792867, 994.0258546624349, 8860.689875854314, 8927.33045021626, 9074.954625226832, 9076.364654474124, 9221.109672517117, 571815.0, 572441.0, 578333.0, 584561.0, 589951.0, 76338.0, 76802.0, 77192.61403692946, 79640.6017969918, 80893.59553202314, 1035.2856528994969, 1055.7782865598156, 1058.2063452410691, 1063.9042486176281, 1087.9075278601408, 14990.47533336328, 15256.542303730906, 15344.923275383551, 15555.0, 15643.608909777347, 34120.829395853856, 34257.314853702286, 35120.29759404849, 35354.0, 35462.82268588641, 43672.781636092885, 44871.102577948914, 45264.54735452735, 45672.77163614161, 46357.304640431095, 8744.912550874664, 9549.570269337757, 9565.473898935625, 9571.425714456876, 9575.569099390405, 13526.323683815966, 16392.098434586213, 16519.66960660804, 16636.334546618, 17017.638588913105, 11978.221415607957, 13531.864681353454, 13978.720425591635, 14332.355044023252, 14466.349014294172, 13684.110532815335, 14132.22272774966, 14156.0, 14286.71426571442, 14415.567532974028, 13732.588022359345, 13776.380062896993, 13861.306934653025, 14309.57071287863, 14446.133232006114, 9406.95296523513, 9622.123685881186, 9624.230061594915, 9634.373765705206, 9834.459104749021, 13417.329133543088, 13464.663383415493, 13672.52146174879, 13863.72272554523, 14719.484818031318], "unit": "score", "name": "jquery.html", "value": 8673.843007814621}, {"lowerIsBetter": false, "replicates": [1278.1883503974973, 1422.7367936931669, 1427.9647255739587, 1539.5227479481362, 1729.0231019473997, 6047.576669633122, 6679.131712877325, 6786.185657721074, 6788.083608712822, 6805.149356330458, 6603.0, 6774.830629234271, 6775.559588626736, 6779.2542820289855, 6784.0, 1841.9263229470805, 1870.8035656256102, 2037.0833125093693, 2078.7921207879244, 2115.3971118231307, 2122.734658167729, 2129.595376878396, 2130.1053557505807, 2130.648443006902, 2134.6050980568566, 2074.5332300232476, 2080.5214800595872, 2125.5430082532253, 2128.4253251622054, 2132.125828410352, 2090.4773806548365, 2091.4875855415366, 2097.08776682143, 2103.463616777727, 2115.7778433264516, 2076.397844625072, 2086.5931143427038, 2089.0181614641097, 2094.183268525276, 2099.391176558796, 6864.965675171592, 6911.412529934962, 6922.03091567181, 6922.930770692329, 6934.375906168419, 4134.297169481196, 4194.874153775391, 4231.576842315774, 4236.9364459533135, 4238.321868501025, 2773.2928103333725, 2838.758705510034, 2871.0956048844546, 2872.023512005907, 2887.7834162437903, 847.2713466418875, 872.7948932000975, 876.1895246896595, 923.1922068190333, 933.1368484152132, 9023.187913087788, 9035.45787252767, 9037.728868133967, 9050.140236677571, 9070.319726020574, 3797.6202379761803, 3808.6572208501366, 3858.074062225046, 3871.7483363581277, 3880.78655673935, 8015.599220038975, 8021.919780802117, 8022.719204827803, 8038.115807261197, 8050.879236811453, 4299.871003869889, 4304.225239456928, 4327.242732521796, 4333.090051089306, 4335.783210839445, 3956.149427873021, 3980.840766369313, 3988.8603898863403, 3993.520777506718, 3994.400839874042, 3075.815451072943, 3114.2214446388402, 3239.6598357172156, 3283.540304357392, 3333.749968752353, 1031.1080915008613, 1033.039273475675, 1040.3341861208833, 1041.5052849896238, 1042.525650828871, 1020.3469779341227, 1021.1167340250778, 1076.2573824061528, 1158.5134243617701, 1335.9465621375036, 6399.200099987502, 6428.646424446701, 6435.74257029723, 6440.4847612190915, 6452.193475815523, 1178.6640807369859, 1179.6991767099335, 1196.186593116689, 1206.1014544164477, 1216.1730023584048, 5230.555402790729, 5290.100682883919, 5312.787488500494, 5325.786968521215, 5329.333833270841, 7734.1492435832015, 8101.959490202511, 8103.4732742372735, 8154.0, 8158.796030099295, 7927.286544211049, 7958.761237162895, 8014.879776803353, 8041.678332866737, 8124.5937703114605, 6390.712417941204, 6503.154589903283, 6589.53873228879, 6649.534532582769, 6713.865722685519, 6481.189851268591, 6484.1894763154605, 6489.123968264224, 6497.0, 6511.674416279262, 7318.414526837947, 7522.097348318237, 7573.015507983927, 7573.697052118074, 7575.24247575238, 7548.584827834522, 7675.654595543102, 7680.3471704905705, 7682.615869206629, 7695.23047695226, 5936.406359364202, 5988.191594134736, 5994.430529099728, 5998.940010599838, 6009.579329446897, 6488.416042556192, 6668.66656667155, 6679.56582822115, 6690.431313338226, 6698.5980841149685, 6136.938630613637, 6147.96926015385, 6158.0, 6184.288806787097, 6351.142595749515, 6215.81352559424, 6235.594686345373, 6248.250209974651, 6261.139710641298, 6329.651869147241, 6124.755009799558, 6130.233720784902, 6225.066240064027, 6225.750969961151, 6246.500279977682, 5812.33158186797, 5899.528037756883, 5904.0553511437965, 5920.674362910081, 5922.644641321534, 5904.114382842608, 5951.434613711691, 5958.374370691015, 5968.253968253968, 5981.282246130492], "unit": "score", "name": "mootools.html", "value": 4050.411936335885}, {"lowerIsBetter": false, "replicates": [327.2146847565842, 327.7902142628718, 330.35745475051004, 336.7827751100541, 337.8023856044214, 5996.190514280571, 6001.3698561651, 6006.8798624027495, 6018.037114061751, 6023.608465449748, 5669.489745922866, 5712.086066229404, 5801.506871915893, 5843.941560584393, 5957.672328021957, 4477.283634618461, 4517.616002639779, 4519.412476378075, 4521.389612402333, 4521.819127234907, 4337.54455782143, 4519.751413672247, 4535.818567257305, 4536.387587675671, 4537.954620453786, 4362.498312694049, 4432.268675668511, 4500.032493014001, 4506.098780243948, 4518.774061296938, 4476.216662084138, 4503.076869241798, 4508.549145085498, 4517.751523666214, 4520.841770538015, 3996.900077498057, 4001.2197621463824, 4009.7594144351433, 4020.0954785173394, 4024.054347228399, 5560.943420750044, 5664.0, 5677.091665333527, 5682.772689092431, 5685.1756495307945, 5339.652922560022, 5340.225667278261, 5341.145416733343, 5341.252224688546, 5345.1447768356875, 6288.0, 6297.716602752841, 6304.306526282106, 6304.401081897213, 6307.306196318401, 4478.350639157336, 4481.686281960264, 4482.462104547475, 4483.439570053743, 4490.932636010462, 6360.204974378203, 6501.512386571026, 6530.346965303432, 6542.869142617169, 6592.439642630382, 4390.648748100144, 4455.376247325312, 4459.643228541709, 4460.1525710114975, 4465.754383508874, 4512.571305725951, 4513.323001549728, 4520.52534483881, 4526.592606665416, 4529.207388706963, 5243.868903277372, 5244.213367994755, 5245.973770131125, 5250.2411692082815, 5251.973740131275, 6123.203983482119, 6293.653849038255, 6303.464205542488, 6307.5269354798575, 6345.206849143857, 1638.2382192280409, 1656.7763351947333, 1656.942007029748, 1658.2040620502225, 1658.4195531564098, 1119.5465836336298, 1128.368113856243, 1130.598637483698, 1140.5152810055692, 1152.1071169843437, 6070.0, 6075.939240607626, 6087.969560152171, 6090.482309003784, 6096.908546371808, 6518.054882042172, 6522.673866306761, 6526.086347911296, 6531.0, 6531.934680653228, 5893.793717219876, 5965.522758179335, 6045.093236014545, 6051.213342265477, 6092.116643086728, 3508.386032444312, 3514.9121271967892, 3538.168530395355, 3539.3629146753833, 3545.3618348697482, 6835.487338449636, 6841.144856892888, 6848.7260509580055, 6851.246362900077, 6859.519833611599, 6604.240512341143, 6754.5947243165565, 6755.054292399068, 6764.0, 6767.086443330186, 6840.042394064835, 6850.828729281709, 6857.897131543031, 6861.897071543931, 6864.279250678706, 6489.513286503626, 6552.246491653521, 6552.6068435894, 6563.442107420923, 6563.803085907431, 6322.272938612118, 6497.18785151856, 6498.252700939453, 6500.0, 6513.15329007245, 6860.622665753232, 6864.965675171592, 6871.209810871814, 6875.759348422781, 6877.58734475913, 4528.728276303433, 4529.162105010583, 4529.932051019171, 4538.591526762607, 4539.568740969603, 6381.712822923072, 6552.213734351908, 6557.836054098495, 6572.737090516517, 6583.967080164569, 6390.360963903759, 6396.840078997876, 6398.488120950406, 6398.71205795731, 6406.455451286506, 6388.616682999035, 6390.073439351361, 6390.13733146038, 6393.552451328363, 6397.616143031433, 6149.385061493815, 6238.968805155945, 6277.340879207617, 6285.182926219562, 6288.905666414916, 6423.357664233539, 6425.357464253537, 6430.967845160744, 6431.1317972073175, 6440.066190402272, 6284.968575157095, 6285.842853928689, 6286.0, 6292.056191571118, 6294.71673774672], "unit": "score", "name": "prototype.html", "value": 4789.339487316879}, {"lowerIsBetter": false, "replicates": [710.2294010998066, 800.8478389106069, 818.7666515043214, 829.5686243153559, 841.486693117198, 13227.470901163953, 13365.064445488819, 13443.395047222873, 13454.461821527128, 13470.3264836758, 12454.377281135952, 12908.225506469618, 12924.418401171946, 12937.935310323459, 12939.741205175915, 671.3890359772608, 679.8912174052152, 685.5612408058846, 811.0348685064783, 825.8100636853527, 805.2551389964289, 819.4182130687219, 821.0434843407453, 824.3734761581211, 826.1985873702499, 856.9143085691412, 857.4598003257938, 858.7080392666492, 859.0250066174874, 859.5186695450568, 699.7550857199965, 700.6146619359357, 836.8159005018947, 856.2892798976866, 857.1214505132227, 630.1587380846576, 631.8041407163794, 632.0613888375758, 633.8035209085152, 634.8317695810567, 12963.935180324132, 12993.87006129936, 13105.344732763419, 13120.409581568756, 13136.0, 11622.59320923772, 11876.703082423008, 12169.0, 12288.078394120388, 12518.06114541404, 9883.209343252594, 9903.45530995795, 9980.800383992351, 10155.390676559357, 10179.287449878511, 3575.1598374382, 3628.8911332660064, 3635.2729454109285, 3643.0710168907026, 3644.599094099647, 46167.76916115431, 46621.53378466206, 47043.05913881737, 48000.51999480031, 48249.27626085612, 9702.466364350028, 9723.562439690231, 9817.263705222136, 9824.754381140387, 9834.606615735434, 17339.739903901453, 17604.207810648553, 17621.7356739649, 17631.382901598638, 17676.0, 7012.403945664676, 7195.496315257882, 7234.674439650228, 7320.267973202637, 7438.66526006331, 4099.938500922489, 4175.958240417557, 4192.098698779777, 4213.852515161954, 4217.219814334358, 3060.525618529087, 3075.4464196444405, 3085.8148511088957, 3086.6141732283463, 3100.023492599824, 550.204953841703, 564.7599770097692, 565.1438071321951, 570.891530609183, 579.6724850459477, 556.9192467092249, 661.2395744893315, 683.7162577530269, 702.5749421599961, 706.6219572528776, 7760.495567788075, 8030.9196908031345, 8043.994500687414, 8127.552984585786, 8347.165283471604, 592.2337296388741, 688.8036909480874, 704.5772536478174, 708.4049398505281, 719.1909102259957, 3620.1854582719207, 3923.7841918694176, 3923.7841918694744, 3977.244323578511, 4045.8786236412957, 52952.0, 52984.47015529795, 53344.46655533473, 53482.0, 53621.73189134029, 46874.531254687696, 47330.0, 50263.74868125709, 50898.0, 51160.488395116314, 42852.785736071746, 44590.0, 45029.774851125534, 45038.549614503434, 45149.548504515195, 8053.0, 8191.467554608931, 8506.0, 8540.786480337792, 8600.440971336842, 33462.0, 33863.49204761881, 34094.0, 34208.315833683686, 34235.0, 40136.799316003235, 43766.124677505635, 44219.33670995002, 44355.0, 44376.0, 10090.747731306776, 10617.734556636145, 10962.177836662442, 11050.620868967279, 11261.831072533754, 11919.821202681793, 12087.39563021863, 12237.571684990982, 12282.14025018276, 12528.123031387715, 10102.141317988053, 10622.681319560426, 10665.786684266426, 10677.412742298937, 10897.945510272399, 10590.16934077531, 10645.627403040857, 10904.34573925567, 10984.505697243483, 10986.725331866768, 10767.0, 10897.56409743633, 11024.007839294502, 11157.330560166416, 11255.212135150461, 9272.953635231781, 9364.448561269222, 9625.807483850424, 9687.854682179914, 9775.755606109904, 8411.747647570583, 8606.741797746077, 8632.78418039554, 9160.946491153336, 9191.172794448532], "unit": "score", "name": "yui.html", "value": 6151.514176740224}], "name": "dromaeo_css", "value": 6763.8900988402}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 110.0, 112.0, 110.0, 99.0, 111.0, 112.0, 101.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [147.0, 125.0, 152.0, 163.0, 127.0, 159.0, 150.0, 131.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 159.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 83.0, 92.0, 71.0, 72.0, 74.0, 111.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 139.0, 96.0, 97.0, 96.0, 150.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 59.0, 58.0, 60.0, 58.0, 60.0, 68.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 87.0, 87.0, 87.0, 87.0, 89.0, 86.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 119.0, 113.0, 114.0, 116.0, 126.0, 119.0, 126.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [142.0, 138.0, 149.0, 150.0, 148.0, 140.0, 150.0, 150.0, 149.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 70.0, 66.0, 67.0, 67.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1501.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [191.16803670426305], "unit": "score", "name": "DeltaBlue", "value": 345.8632580000001}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [2036.6598778004072], "unit": "score", "name": "RayTrace", "value": 363.33459900000014}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [657.1609632446134], "unit": "score", "name": "Splay", "value": 124.00462680810034}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19516.25661849186}]} 20:09:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19516.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6763.89"}}} 20:09:50 INFO - Return code: 0 20:09:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:09:50 INFO - # TBPL SUCCESS # 20:09:50 INFO - Running post-action listener: _resource_record_post_action 20:09:50 INFO - Running post-run listener: _resource_record_post_run 20:09:51 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 225280; Write bytes: 556630016; Read time: 60; Write time: 744268 20:09:51 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248885248; Read time: 0; Write time: 442972 20:09:51 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 225280; Write bytes: 307744768; Read time: 60; Write time: 301296 20:09:51 INFO - Running post-run listener: _upload_blobber_files 20:09:51 INFO - Blob upload gear active. 20:09:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:09:51 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 20:09:51 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'] 20:09:51 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 20:09:51 INFO - (blobuploader) - INFO - Open directory for files ... 20:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:52 INFO - (blobuploader) - INFO - Done attempting. 20:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:53 INFO - (blobuploader) - INFO - Done attempting. 20:09:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:09:53 INFO - Return code: 0 20:09:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:09:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:09:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2881d31eac62da5db0af18d9a3067cdd3e4d1790a994f3e1d290b171591209a5067b826397e41e3032a1b7f91cfea31b8495a3e34f9d5c42074d71fc3dd595b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8610fb636db7ae0e9913027b9da98b17be156e8febe26d94661ce3ae84cd0cb182294f754f3fb9c5106392bd998d31ca35b04b1057aaabb782ce4d1a8448cb"} 20:09:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:09:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:09:53 INFO - Contents: 20:09:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2881d31eac62da5db0af18d9a3067cdd3e4d1790a994f3e1d290b171591209a5067b826397e41e3032a1b7f91cfea31b8495a3e34f9d5c42074d71fc3dd595b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8610fb636db7ae0e9913027b9da98b17be156e8febe26d94661ce3ae84cd0cb182294f754f3fb9c5106392bd998d31ca35b04b1057aaabb782ce4d1a8448cb"} 20:09:53 INFO - Copying logs to upload dir... 20:09:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.637095 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-29 20:09:53.193412) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:53.196895) ========= 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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 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/2881d31eac62da5db0af18d9a3067cdd3e4d1790a994f3e1d290b171591209a5067b826397e41e3032a1b7f91cfea31b8495a3e34f9d5c42074d71fc3dd595b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8610fb636db7ae0e9913027b9da98b17be156e8febe26d94661ce3ae84cd0cb182294f754f3fb9c5106392bd998d31ca35b04b1057aaabb782ce4d1a8448cb"} build_url:https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/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/2881d31eac62da5db0af18d9a3067cdd3e4d1790a994f3e1d290b171591209a5067b826397e41e3032a1b7f91cfea31b8495a3e34f9d5c42074d71fc3dd595b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee8610fb636db7ae0e9913027b9da98b17be156e8febe26d94661ce3ae84cd0cb182294f754f3fb9c5106392bd998d31ca35b04b1057aaabb782ce4d1a8448cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:53.221092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:53.221377) ========= 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=6587686cb2da90a5f91b3170000001be-1451435190.540612-555746373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:53.307202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 20:09:53.307518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 20:09:53.307792) ========= ========= Total master_lag: 0.24 =========