builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1452052703.73 results: success (0) buildid: 20160105173012 builduid: dc8be0bedd774e85a49d128dc97e9a95 revision: 42b90df5e0e790b353b3c0dcd14bad80412e02de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.732187) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.732709) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.733052) ========= 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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005088 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.754852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.755259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.769151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.769574) ========= 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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.819206) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.819548) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.819947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.820295) ========= 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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 19:58:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.5M=0s 2016-01-05 19:58:24 (59.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.997149) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:23.997504) ========= 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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.011440 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:24.048044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 19:58:24.048598) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 42b90df5e0e790b353b3c0dcd14bad80412e02de --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 42b90df5e0e790b353b3c0dcd14bad80412e02de --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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 19:58:24,184 truncating revision to first 12 chars 2016-01-05 19:58:24,184 Setting DEBUG logging. 2016-01-05 19:58:24,184 attempt 1/10 2016-01-05 19:58:24,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/42b90df5e0e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 19:58:25,434 unpacking tar archive at: fx-team-42b90df5e0e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.551379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 19:58:25.613962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:25.614425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:25.657378) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:25.657813) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 19:58:25.658319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-05 19:58:25.658693) ========= /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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:25 INFO - MultiFileLogger online at 20160105 19:58:25 in /builds/slave/test-pgo 19:58:25 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:58:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:58:25 INFO - {'append_to_log': False, 19:58:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:58:25 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:58:25 INFO - 'branch': 'Fx-Team', 19:58:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:25 INFO - 'config_files': ('talos/linux_config.py',), 19:58:25 INFO - 'default_actions': ('clobber', 19:58:25 INFO - 'read-buildbot-config', 19:58:25 INFO - 'download-and-extract', 19:58:25 INFO - 'populate-webroot', 19:58:25 INFO - 'create-virtualenv', 19:58:25 INFO - 'install', 19:58:25 INFO - 'run-tests'), 19:58:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:25 INFO - 'download_minidump_stackwalk': True, 19:58:25 INFO - 'download_symbols': 'ondemand', 19:58:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:25 INFO - 'installer_path': 'installer.exe', 19:58:25 INFO - 'log_level': 'info', 19:58:25 INFO - 'log_name': 'talos', 19:58:25 INFO - 'log_to_console': True, 19:58:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:25 INFO - 'opt_config_files': (), 19:58:25 INFO - 'pip_index': False, 19:58:25 INFO - 'sps_profile': False, 19:58:25 INFO - 'sps_profile_interval': 0, 19:58:25 INFO - 'suite': 'dromaeojs', 19:58:25 INFO - 'system_bits': '32', 19:58:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:25 INFO - 'title': 'talos-linux64-ix-024', 19:58:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:25 INFO - 'use_talos_json': True, 19:58:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:58:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:25 INFO - 'work_dir': 'build'} 19:58:25 INFO - ##### 19:58:25 INFO - ##### Running clobber step. 19:58:25 INFO - ##### 19:58:25 INFO - Running pre-action listener: _resource_record_pre_action 19:58:25 INFO - Running main action method: clobber 19:58:25 INFO - rmtree: /builds/slave/test-pgo/build 19:58:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:58:26 INFO - Running post-action listener: _resource_record_post_action 19:58:26 INFO - ##### 19:58:26 INFO - ##### Running read-buildbot-config step. 19:58:26 INFO - ##### 19:58:26 INFO - Running pre-action listener: _resource_record_pre_action 19:58:26 INFO - Running main action method: read_buildbot_config 19:58:26 INFO - Using buildbot properties: 19:58:26 INFO - { 19:58:26 INFO - "project": "", 19:58:26 INFO - "product": "firefox", 19:58:26 INFO - "script_repo_revision": "production", 19:58:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:58:26 INFO - "repository": "", 19:58:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:58:26 INFO - "buildid": "20160105173012", 19:58:26 INFO - "pgo_build": "True", 19:58:26 INFO - "basedir": "/builds/slave/test-pgo", 19:58:26 INFO - "buildnumber": 874, 19:58:26 INFO - "slavename": "talos-linux64-ix-024", 19:58:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:58:26 INFO - "platform": "ubuntu64_hw", 19:58:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:26 INFO - "branch": "fx-team", 19:58:26 INFO - "repo_path": "integration/fx-team", 19:58:26 INFO - "revision": "42b90df5e0e790b353b3c0dcd14bad80412e02de", 19:58:26 INFO - "stage_platform": "linux64-pgo", 19:58:26 INFO - "builduid": "dc8be0bedd774e85a49d128dc97e9a95", 19:58:26 INFO - "slavebuilddir": "test" 19:58:26 INFO - } 19:58:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:58:26 INFO - Running post-action listener: _resource_record_post_action 19:58:26 INFO - ##### 19:58:26 INFO - ##### Running download-and-extract step. 19:58:26 INFO - ##### 19:58:26 INFO - Running pre-action listener: _resource_record_pre_action 19:58:26 INFO - Running main action method: download_and_extract 19:58:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:26 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json 19:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json 19:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:58:26 INFO - Downloaded 1302 bytes. 19:58:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:58:26 INFO - Using the following test package requirements: 19:58:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'jsshell-linux-x86_64.zip'], 19:58:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:26 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:28 INFO - Downloaded 24055319 bytes. 19:58:28 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:58:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:28 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:58:29 INFO - Return code: 0 19:58:29 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:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:29 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:30 INFO - Downloaded 24055319 bytes. 19:58:30 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:58:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:30 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:58:31 INFO - Return code: 0 19:58:31 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:58:31 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:33 INFO - Downloaded 11132285 bytes. 19:58:33 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:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:33 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:58:33 INFO - Return code: 0 19:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:33 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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:58:34 INFO - Downloaded 55049010 bytes. 19:58:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:34 INFO - mkdir: /builds/slave/test-pgo/properties 19:58:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:58:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:58:34 INFO - Contents: 19:58:34 INFO - build_url:https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:34 INFO - Running post-action listener: _resource_record_post_action 19:58:34 INFO - Running post-action listener: set_extra_try_arguments 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running populate-webroot step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: populate_webroot 19:58:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:34 INFO - '--tppagecycles', 19:58:34 INFO - '7'], 19:58:34 INFO - 'tests': ['tsvgm']}}, 19:58:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:58:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'tests': ['damp', 'tps']}, 19:58:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['damp', 'tps']}, 19:58:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:58:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:34 INFO - 'other': {'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore']}, 19:58:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore']}, 19:58:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore']}, 19:58:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore']}, 19:58:34 INFO - 'other_l64': {'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore']}, 19:58:34 INFO - 'other_nol64': {'tests': ['a11yr', 19:58:34 INFO - 'ts_paint', 19:58:34 INFO - 'tpaint', 19:58:34 INFO - 'sessionrestore', 19:58:34 INFO - 'sessionrestore_no_auto_restore']}, 19:58:34 INFO - 'svgr': {'tests': ['tsvgx', 19:58:34 INFO - 'tsvgr_opacity', 19:58:34 INFO - 'tart', 19:58:34 INFO - 'tscrollx', 19:58:34 INFO - 'cart']}, 19:58:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['tsvgx', 19:58:34 INFO - 'tsvgr_opacity', 19:58:34 INFO - 'tart', 19:58:34 INFO - 'tscrollx', 19:58:34 INFO - 'cart']}, 19:58:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'tests': ['tp5o']}, 19:58:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--e10s'], 19:58:34 INFO - 'tests': ['tp5o']}, 19:58:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--xperf_path', 19:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:34 INFO - 'tests': ['tp5n']}, 19:58:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:34 INFO - 'talos_options': ['--e10s', 19:58:34 INFO - '--xperf_path', 19:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:34 INFO - 'tests': ['tp5n']}}, 19:58:34 INFO - 'talos.zip': {'path': '', 19:58:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:34 INFO - Running post-action listener: _resource_record_post_action 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running create-virtualenv step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: create_virtualenv 19:58:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:58:34 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:58:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:58:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:34 INFO - Using real prefix '/usr' 19:58:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:58:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:37 INFO - Installing pip.................done. 19:58:37 INFO - Return code: 0 19:58:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:37 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 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:37 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:58:37 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:58:37 INFO - Using env: {'DISPLAY': ':0', 19:58:37 INFO - 'HOME': '/home/cltbld', 19:58:37 INFO - 'LANG': 'en_US.UTF-8', 19:58:37 INFO - 'LANGUAGE': 'en_US:en', 19:58:37 INFO - 'LOGNAME': 'cltbld', 19:58:37 INFO - 'MAIL': '/var/mail/cltbld', 19:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:37 INFO - 'MOZ_NO_REMOTE': '1', 19:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:37 INFO - 'NO_EM_RESTART': '1', 19:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:37 INFO - 'SHELL': '/bin/bash', 19:58:37 INFO - 'SHLVL': '1', 19:58:37 INFO - 'TERM': 'linux', 19:58:37 INFO - 'TMOUT': '86400', 19:58:37 INFO - 'USER': 'cltbld', 19:58:37 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:37 INFO - '_': '/tools/buildbot/bin/python'} 19:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:37 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:58:37 INFO - Cleaning up... 19:58:37 INFO - Return code: 0 19:58:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:37 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 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:37 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:58:37 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:58:37 INFO - Using env: {'DISPLAY': ':0', 19:58:37 INFO - 'HOME': '/home/cltbld', 19:58:37 INFO - 'LANG': 'en_US.UTF-8', 19:58:37 INFO - 'LANGUAGE': 'en_US:en', 19:58:37 INFO - 'LOGNAME': 'cltbld', 19:58:37 INFO - 'MAIL': '/var/mail/cltbld', 19:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:37 INFO - 'MOZ_NO_REMOTE': '1', 19:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:37 INFO - 'NO_EM_RESTART': '1', 19:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:37 INFO - 'SHELL': '/bin/bash', 19:58:37 INFO - 'SHLVL': '1', 19:58:37 INFO - 'TERM': 'linux', 19:58:37 INFO - 'TMOUT': '86400', 19:58:37 INFO - 'USER': 'cltbld', 19:58:37 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:37 INFO - '_': '/tools/buildbot/bin/python'} 19:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:37 INFO - Downloading/unpacking psutil>=0.7.1 19:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:58:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:58:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:39 INFO - Installing collected packages: psutil 19:58:39 INFO - Running setup.py install for psutil 19:58:39 INFO - building 'psutil._psutil_linux' extension 19:58:39 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:58:39 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:58:39 INFO - building 'psutil._psutil_posix' extension 19:58:39 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:58:40 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:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:40 INFO - Successfully installed psutil 19:58:40 INFO - Cleaning up... 19:58:40 INFO - Return code: 0 19:58:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:40 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 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:40 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:58:40 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:58:40 INFO - Using env: {'DISPLAY': ':0', 19:58:40 INFO - 'HOME': '/home/cltbld', 19:58:40 INFO - 'LANG': 'en_US.UTF-8', 19:58:40 INFO - 'LANGUAGE': 'en_US:en', 19:58:40 INFO - 'LOGNAME': 'cltbld', 19:58:40 INFO - 'MAIL': '/var/mail/cltbld', 19:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:40 INFO - 'MOZ_NO_REMOTE': '1', 19:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:40 INFO - 'NO_EM_RESTART': '1', 19:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:40 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:40 INFO - 'SHELL': '/bin/bash', 19:58:40 INFO - 'SHLVL': '1', 19:58:40 INFO - 'TERM': 'linux', 19:58:40 INFO - 'TMOUT': '86400', 19:58:40 INFO - 'USER': 'cltbld', 19:58:40 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:40 INFO - '_': '/tools/buildbot/bin/python'} 19:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:58:40 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:58:40 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:58:40 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:58:40 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:58:40 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:58:40 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:58:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:58:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:42 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:58:42 INFO - Installing collected packages: mozsystemmonitor 19:58:42 INFO - Running setup.py install for mozsystemmonitor 19:58:42 INFO - Successfully installed mozsystemmonitor 19:58:42 INFO - Cleaning up... 19:58:42 INFO - Return code: 0 19:58:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:58:42 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:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 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:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 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 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:42 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:58:42 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:58:42 INFO - Using env: {'DISPLAY': ':0', 19:58:42 INFO - 'HOME': '/home/cltbld', 19:58:42 INFO - 'LANG': 'en_US.UTF-8', 19:58:42 INFO - 'LANGUAGE': 'en_US:en', 19:58:42 INFO - 'LOGNAME': 'cltbld', 19:58:42 INFO - 'MAIL': '/var/mail/cltbld', 19:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:42 INFO - 'MOZ_NO_REMOTE': '1', 19:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:42 INFO - 'NO_EM_RESTART': '1', 19:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:42 INFO - 'SHELL': '/bin/bash', 19:58:42 INFO - 'SHLVL': '1', 19:58:42 INFO - 'TERM': 'linux', 19:58:42 INFO - 'TMOUT': '86400', 19:58:42 INFO - 'USER': 'cltbld', 19:58:42 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:42 INFO - '_': '/tools/buildbot/bin/python'} 19:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:42 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:44 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:58:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 INFO - Downloading docopt-0.6.1.tar.gz 19:58:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:44 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:44 INFO - Running setup.py install for blobuploader 19:58:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:58:45 INFO - Running setup.py install for requests 19:58:45 INFO - Running setup.py install for docopt 19:58:45 INFO - Successfully installed blobuploader requests docopt 19:58:45 INFO - Cleaning up... 19:58:45 INFO - Return code: 0 19:58:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:45 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 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:45 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:58:45 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:58:45 INFO - Using env: {'DISPLAY': ':0', 19:58:45 INFO - 'HOME': '/home/cltbld', 19:58:45 INFO - 'LANG': 'en_US.UTF-8', 19:58:45 INFO - 'LANGUAGE': 'en_US:en', 19:58:45 INFO - 'LOGNAME': 'cltbld', 19:58:45 INFO - 'MAIL': '/var/mail/cltbld', 19:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:45 INFO - 'MOZ_NO_REMOTE': '1', 19:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:45 INFO - 'NO_EM_RESTART': '1', 19:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:45 INFO - 'SHELL': '/bin/bash', 19:58:45 INFO - 'SHLVL': '1', 19:58:45 INFO - 'TERM': 'linux', 19:58:45 INFO - 'TMOUT': '86400', 19:58:45 INFO - 'USER': 'cltbld', 19:58:45 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:45 INFO - '_': '/tools/buildbot/bin/python'} 19:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:45 INFO - Running setup.py (path:/tmp/pip-TMvm0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:45 INFO - Running setup.py (path:/tmp/pip-XbL2nq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:45 INFO - Running setup.py (path:/tmp/pip-_salL_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:45 INFO - Running setup.py (path:/tmp/pip-aJRTeo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:46 INFO - Running setup.py (path:/tmp/pip-F_z8aN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:46 INFO - Running setup.py (path:/tmp/pip-u1kF4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:46 INFO - Running setup.py (path:/tmp/pip-ldTwQ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:46 INFO - Running setup.py (path:/tmp/pip-tTOcfH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:46 INFO - Running setup.py (path:/tmp/pip-CJ7owg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:46 INFO - Running setup.py (path:/tmp/pip-sWUwaG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:46 INFO - Running setup.py (path:/tmp/pip-cpXuBs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:46 INFO - Running setup.py (path:/tmp/pip-pprd8e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:46 INFO - Running setup.py (path:/tmp/pip-Iu1EuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:46 INFO - Running setup.py (path:/tmp/pip-RcFzsq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:46 INFO - Running setup.py (path:/tmp/pip-V3oyb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:46 INFO - Running setup.py (path:/tmp/pip-n7_rHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:46 INFO - Running setup.py (path:/tmp/pip-EYupyk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:46 INFO - Running setup.py install for manifestparser 19:58:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Running setup.py install for mozcrash 19:58:47 INFO - Running setup.py install for mozdebug 19:58:47 INFO - Running setup.py install for mozdevice 19:58:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Running setup.py install for mozfile 19:58:47 INFO - Running setup.py install for mozhttpd 19:58:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Running setup.py install for mozinfo 19:58:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Running setup.py install for mozInstall 19:58:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:58:47 INFO - Running setup.py install for mozleak 19:58:47 INFO - Running setup.py install for mozlog 19:58:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:58:48 INFO - Running setup.py install for moznetwork 19:58:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:58:48 INFO - Running setup.py install for mozprocess 19:58:48 INFO - Running setup.py install for mozprofile 19:58:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:58:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:58:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:58:48 INFO - Running setup.py install for mozrunner 19:58:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:58:48 INFO - Running setup.py install for mozscreenshot 19:58:48 INFO - Running setup.py install for moztest 19:58:48 INFO - Running setup.py install for mozversion 19:58:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:58:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:48 INFO - Cleaning up... 19:58:48 INFO - Return code: 0 19:58:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:48 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:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:48 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:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:48 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 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:48 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:58:48 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:58:48 INFO - Using env: {'DISPLAY': ':0', 19:58:48 INFO - 'HOME': '/home/cltbld', 19:58:48 INFO - 'LANG': 'en_US.UTF-8', 19:58:48 INFO - 'LANGUAGE': 'en_US:en', 19:58:48 INFO - 'LOGNAME': 'cltbld', 19:58:48 INFO - 'MAIL': '/var/mail/cltbld', 19:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:48 INFO - 'MOZ_NO_REMOTE': '1', 19:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:48 INFO - 'NO_EM_RESTART': '1', 19:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:48 INFO - 'SHELL': '/bin/bash', 19:58:48 INFO - 'SHLVL': '1', 19:58:48 INFO - 'TERM': 'linux', 19:58:48 INFO - 'TMOUT': '86400', 19:58:48 INFO - 'USER': 'cltbld', 19:58:48 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:48 INFO - '_': '/tools/buildbot/bin/python'} 19:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:48 INFO - Running setup.py (path:/tmp/pip-aLC8XZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:49 INFO - Running setup.py (path:/tmp/pip-WDn2Ki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:49 INFO - Running setup.py (path:/tmp/pip-hJ46Sn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:49 INFO - Running setup.py (path:/tmp/pip-6_oNzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:49 INFO - Running setup.py (path:/tmp/pip-RbqQaE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:49 INFO - Running setup.py (path:/tmp/pip-P5jIkp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:49 INFO - Running setup.py (path:/tmp/pip-pN4UeS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:49 INFO - Running setup.py (path:/tmp/pip-ui5VBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:49 INFO - Running setup.py (path:/tmp/pip-Z_qGzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:49 INFO - Running setup.py (path:/tmp/pip-CUXPuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:49 INFO - Running setup.py (path:/tmp/pip-EjeZC7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:49 INFO - Running setup.py (path:/tmp/pip-zmdsdn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:49 INFO - Running setup.py (path:/tmp/pip-f8_grs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:49 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:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:49 INFO - Running setup.py (path:/tmp/pip-fgkkuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:50 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:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:50 INFO - Running setup.py (path:/tmp/pip-FPgUyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:50 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:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:50 INFO - Running setup.py (path:/tmp/pip-wmvTVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:50 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:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:50 INFO - Running setup.py (path:/tmp/pip-ENIt7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:51 INFO - Downloading blessings-1.5.1.tar.gz 19:58:51 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:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:52 INFO - Installing collected packages: blessings 19:58:52 INFO - Running setup.py install for blessings 19:58:52 INFO - Successfully installed blessings 19:58:52 INFO - Cleaning up... 19:58:52 INFO - Return code: 0 19:58:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:58:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:58:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:58:52 INFO - Reading from file tmpfile_stdout 19:58:52 INFO - Current package versions: 19:58:52 INFO - argparse == 1.2.1 19:58:52 INFO - blessings == 1.5.1 19:58:52 INFO - blobuploader == 1.2.4 19:58:52 INFO - docopt == 0.6.1 19:58:52 INFO - manifestparser == 1.1 19:58:52 INFO - mozInstall == 1.12 19:58:52 INFO - mozcrash == 0.16 19:58:52 INFO - mozdebug == 0.1 19:58:52 INFO - mozdevice == 0.47 19:58:52 INFO - mozfile == 1.2 19:58:52 INFO - mozhttpd == 0.7 19:58:52 INFO - mozinfo == 0.9 19:58:52 INFO - mozleak == 0.1 19:58:52 INFO - mozlog == 3.1 19:58:52 INFO - moznetwork == 0.27 19:58:52 INFO - mozprocess == 0.22 19:58:52 INFO - mozprofile == 0.28 19:58:52 INFO - mozrunner == 6.11 19:58:52 INFO - mozscreenshot == 0.1 19:58:52 INFO - mozsystemmonitor == 0.0 19:58:52 INFO - moztest == 0.7 19:58:52 INFO - mozversion == 1.4 19:58:52 INFO - psutil == 3.1.1 19:58:52 INFO - requests == 1.2.3 19:58:52 INFO - wsgiref == 0.1.2 19:58:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58: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:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:52 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:58:52 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:58:52 INFO - Using env: {'DISPLAY': ':0', 19:58:52 INFO - 'HOME': '/home/cltbld', 19:58:52 INFO - 'LANG': 'en_US.UTF-8', 19:58:52 INFO - 'LANGUAGE': 'en_US:en', 19:58:52 INFO - 'LOGNAME': 'cltbld', 19:58:52 INFO - 'MAIL': '/var/mail/cltbld', 19:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:52 INFO - 'MOZ_NO_REMOTE': '1', 19:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:52 INFO - 'NO_EM_RESTART': '1', 19:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:52 INFO - 'SHELL': '/bin/bash', 19:58:52 INFO - 'SHLVL': '1', 19:58:52 INFO - 'TERM': 'linux', 19:58:52 INFO - 'TMOUT': '86400', 19:58:52 INFO - 'USER': 'cltbld', 19:58:52 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:52 INFO - '_': '/tools/buildbot/bin/python'} 19:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 INFO - Cleaning up... 19:58:52 INFO - Return code: 0 19:58:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:58: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:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:58:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:58:52 INFO - Using env: {'DISPLAY': ':0', 19:58:52 INFO - 'HOME': '/home/cltbld', 19:58:52 INFO - 'LANG': 'en_US.UTF-8', 19:58:52 INFO - 'LANGUAGE': 'en_US:en', 19:58:52 INFO - 'LOGNAME': 'cltbld', 19:58:52 INFO - 'MAIL': '/var/mail/cltbld', 19:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:52 INFO - 'MOZ_NO_REMOTE': '1', 19:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:52 INFO - 'NO_EM_RESTART': '1', 19:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:52 INFO - 'SHELL': '/bin/bash', 19:58:52 INFO - 'SHLVL': '1', 19:58:52 INFO - 'TERM': 'linux', 19:58:52 INFO - 'TMOUT': '86400', 19:58:52 INFO - 'USER': 'cltbld', 19:58:52 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:52 INFO - '_': '/tools/buildbot/bin/python'} 19:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:52 INFO - Downloading/unpacking jsonschema 19:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:52 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:58:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:54 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:58:54 INFO - Downloading/unpacking functools32 (from jsonschema) 19:58:54 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:58:54 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:58:54 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:58:54 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:58:54 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:58:54 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:58:54 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:54 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:58:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:54 INFO - warning: no files found matching '*.txt' 19:58:54 INFO - no previously-included directories found matching 'build' 19:58:54 INFO - no previously-included directories found matching 'dist' 19:58:54 INFO - no previously-included directories found matching '.git*' 19:58:54 INFO - Installing collected packages: jsonschema, functools32 19:58:54 INFO - Running setup.py install for functools32 19:58:54 INFO - warning: no files found matching '*.txt' 19:58:54 INFO - no previously-included directories found matching 'build' 19:58:54 INFO - no previously-included directories found matching 'dist' 19:58:54 INFO - no previously-included directories found matching '.git*' 19:58:54 INFO - Successfully installed jsonschema functools32 19:58:54 INFO - Cleaning up... 19:58:55 INFO - Return code: 0 19:58:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34a527ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', '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:58:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:58:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:58:55 INFO - Using env: {'DISPLAY': ':0', 19:58:55 INFO - 'HOME': '/home/cltbld', 19:58:55 INFO - 'LANG': 'en_US.UTF-8', 19:58:55 INFO - 'LANGUAGE': 'en_US:en', 19:58:55 INFO - 'LOGNAME': 'cltbld', 19:58:55 INFO - 'MAIL': '/var/mail/cltbld', 19:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:55 INFO - 'MOZ_NO_REMOTE': '1', 19:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:55 INFO - 'NO_EM_RESTART': '1', 19:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:55 INFO - 'SHELL': '/bin/bash', 19:58:55 INFO - 'SHLVL': '1', 19:58:55 INFO - 'TERM': 'linux', 19:58:55 INFO - 'TMOUT': '86400', 19:58:55 INFO - 'USER': 'cltbld', 19:58:55 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:55 INFO - '_': '/tools/buildbot/bin/python'} 19:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:55 INFO - Downloading/unpacking flake8 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:58:56 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:58:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:58:57 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:58:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 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:58:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:58:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:57 INFO - no previously-included directories found matching 'docs/_build' 19:58:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:58:57 INFO - Running setup.py install for pep8 19:58:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:57 INFO - no previously-included directories found matching 'docs/_build' 19:58:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:58:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:58:57 INFO - Cleaning up... 19:58:57 INFO - Return code: 0 19:58:57 INFO - Running post-action listener: _resource_record_post_action 19:58:57 INFO - Running post-action listener: _start_resource_monitoring 19:58:57 INFO - Starting resource monitoring. 19:58:57 INFO - ##### 19:58:57 INFO - ##### Running install step. 19:58:57 INFO - ##### 19:58:57 INFO - Running pre-action listener: _resource_record_pre_action 19:58:57 INFO - Running main action method: install 19:58:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:58:58 INFO - Reading from file tmpfile_stdout 19:58:58 INFO - Detecting whether we're running mozinstall >=1.0... 19:58:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:58:58 INFO - Reading from file tmpfile_stdout 19:58:58 INFO - Output received: 19:58:58 INFO - Usage: mozinstall [options] installer 19:58:58 INFO - Options: 19:58:58 INFO - -h, --help show this help message and exit 19:58:58 INFO - -d DEST, --destination=DEST 19:58:58 INFO - Directory to install application into. [default: 19:58:58 INFO - "/builds/slave/test-pgo"] 19:58:58 INFO - --app=APP Application being installed. [default: firefox] 19:58:58 INFO - mkdir: /builds/slave/test-pgo/build/application 19:58:58 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:58:58 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:59:13 INFO - Reading from file tmpfile_stdout 19:59:13 INFO - Output received: 19:59:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:59:13 INFO - Running post-action listener: _resource_record_post_action 19:59:13 INFO - ##### 19:59:13 INFO - ##### Running run-tests step. 19:59:13 INFO - ##### 19:59:14 INFO - Running pre-action listener: _resource_record_pre_action 19:59:14 INFO - Running main action method: run_tests 19:59:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:59:14 INFO - Python 2.7.3 19:59:14 INFO - Return code: 0 19:59:14 INFO - grabbing minidump binary from tooltool 19:59:14 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:59:14 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 0x1def840>, '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 0x1d5c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:59:14 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:59:14 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:59:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:14 INFO - Return code: 0 19:59:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:59:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:59:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:59:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:59:14 INFO - Return code: 0 19:59:14 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/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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:59:14 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/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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:59:15 INFO - Using env: {'DISPLAY': ':0', 19:59:15 INFO - 'HOME': '/home/cltbld', 19:59:15 INFO - 'LANG': 'en_US.UTF-8', 19:59:15 INFO - 'LANGUAGE': 'en_US:en', 19:59:15 INFO - 'LOGNAME': 'cltbld', 19:59:15 INFO - 'MAIL': '/var/mail/cltbld', 19:59:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:15 INFO - 'MOZ_NO_REMOTE': '1', 19:59:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:15 INFO - 'NO_EM_RESTART': '1', 19:59:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:15 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:59:15 INFO - 'SHELL': '/bin/bash', 19:59:15 INFO - 'SHLVL': '1', 19:59:15 INFO - 'TERM': 'linux', 19:59:15 INFO - 'TMOUT': '86400', 19:59:15 INFO - 'USER': 'cltbld', 19:59:15 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894', 19:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:15 INFO - '_': '/tools/buildbot/bin/python'} 19:59:15 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/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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:59:15 INFO - mozversion application_buildid: 20160105173012 19:59:15 INFO - mozversion application_changeset: 42b90df5e0e790b353b3c0dcd14bad80412e02de 19:59:15 INFO - mozversion application_display_name: Nightly 19:59:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:15 INFO - mozversion application_name: Firefox 19:59:15 INFO - mozversion application_remotingname: firefox 19:59:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:15 INFO - mozversion application_vendor: Mozilla 19:59:15 INFO - mozversion application_version: 46.0a1 19:59:15 INFO - mozversion platform_buildid: 20160105173012 19:59:15 INFO - mozversion platform_changeset: 42b90df5e0e790b353b3c0dcd14bad80412e02de 19:59:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:15 INFO - mozversion platform_version: 46.0a1 19:59:15 INFO - using testdate: 1452052755 19:59:15 INFO - actual date: 1452052755 19:59:15 INFO - starting webserver on 'localhost:44496' 19:59:15 INFO - SUITE-START | Running 3 tests 19:59:15 INFO - TEST-START | dromaeo_css 19:59:15 INFO - operating with platform_type : linux_ 19:59:15 INFO - Initialising browser for dromaeo_css test... 19:59:15 INFO - TEST-INFO | started process 30410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdZEE7b/profile http://localhost:44496/getInfo.html) 19:59:19 INFO - PROCESS | 30410 | __metrics Screen width/height:1600/1200 19:59:19 INFO - PROCESS | 30410 | colorDepth:24 19:59:19 INFO - PROCESS | 30410 | Browser inner width/height: 1024/697 19:59:19 INFO - PROCESS | 30410 | __metrics 19:59:19 INFO - PROCESS | 30410 | 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:59:19 INFO - PROCESS | 30410 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:59:19 INFO - PROCESS | 30410 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:59:20 INFO - TEST-INFO | 30410: exit 0 19:59:20 INFO - Browser initialized. 19:59:20 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:20 INFO - TEST-INFO | started process 30503 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdZEE7b/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:32 INFO - PROCESS | 30503 | RSS: Main: 147525632 19:59:32 INFO - PROCESS | 30503 | 20:00:23 INFO - PROCESS | 30503 | 1452052823680 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] 20:02:31 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:44496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44496/tests/dromaeo/cssquery-ext.html) 20:02:33 INFO - PROCESS | 30503 | RSS: Main: 283394048 20:02:33 INFO - PROCESS | 30503 | 20:05:35 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:44496/tests/dromaeo/cssquery-ext.html (next: http://localhost:44496/tests/dromaeo/cssquery-jquery.html) 20:05:36 INFO - PROCESS | 30503 | RSS: Main: 240111616 20:05:36 INFO - PROCESS | 30503 | 20:08:38 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:44496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44496/tests/dromaeo/cssquery-mootools.html) 20:08:38 INFO - PROCESS | 30503 | RSS: Main: 232779776 20:08:38 INFO - PROCESS | 30503 | 20:11:40 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:44496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44496/tests/dromaeo/cssquery-prototype.html) 20:11:41 INFO - PROCESS | 30503 | RSS: Main: 212058112 20:11:41 INFO - PROCESS | 30503 | 20:14:43 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:44496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44496/tests/dromaeo/cssquery-yui.html) 20:14:44 INFO - PROCESS | 30503 | RSS: Main: 218009600 20:14:44 INFO - PROCESS | 30503 | 20:17:46 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:44496/tests/dromaeo/cssquery-yui.html (next: http://localhost:44496/tests/dromaeo/cssquery-dojo.html) 20:17:47 INFO - PROCESS | 30503 | RSS: Main: 260403200 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | __start_tp_report 20:17:47 INFO - PROCESS | 30503 | _x_x_mozilla_page_load 20:17:47 INFO - PROCESS | 30503 | _x_x_mozilla_page_load_details 20:17:47 INFO - PROCESS | 30503 | |i|pagename|runs| 20:17:47 INFO - PROCESS | 30503 | |0;dojo.html;3106.4874295741197;3157.731592814611;3169.2710676544407;3201.503766916129;3216.0673404712634;4961.776720047597;5111.361079865017;5119;5149.794008239666;5181.067407866587;5087.821926232583;5098.133317336053;5157.819476318329;5169.379674439063;5195.19474481455;4675.181843177447;4684.1334353144775;4684.906301873961;4747.121782470237;4772.141014617368;4796.280557916306;4799.832005879794;4807.903841923159;4851.417829860422;4861.003494283681;4647.697899636512;4648.558386953234;4722.7402492862875;4751.073540659573;4772.164871147553;4724.480307166209;4732.597729193023;4740.691855029412;4755.595774359183;4803.423589169287;4615.607673347769;4707.882302942419;4712.986707857827;4723.976380118077;4764.285357196413;4973.3286006389035;4980.626453016038;5051.696898186121;5070.264811602334;5103.923441148386;5470.452954704538;5492.176173573956;5493.917591236134;5494.148406996922;5497.890042199174;5354.812581559666;5501.0098182327165;5524.558035357162;5527.032769265363;5559.999200143972;5052.1411360068505;5091.490850914916;5105.463926287761;5106.974465127688;5159.922601160985;5581.162825576196;5657.4908258256955;5657.57568182388;5658.264425624642;5663;5295.549878260314;5402.648827826179;5413.215083812904;5444.1017232156255;5473.726313684379;5480.068388373986;5558.305211848519;5567.387587365387;5569.944300557024;5597.160425936142;5460.6177567569885;5469.671819690831;5471.316085489314;5471.452854714496;5472.124460086367;5290.603204759582;5407.351117865803;5453.15476101205;5462.453754624586;5507.284053073155;4292.613664770123;4317;4317.935230971538;4353.020570371641;4379.080393117417;3823.9808800955816;3849.4225866120305;3858.6913046956174;3875.903102422462;3892.2799282132896;4952.62855285855;5057.443681195065;5059.114654935372;5067.949320506821;5085.288059671649;5412.188171774265;5473.534749546254;5489;5490.066688662937;5520.806771762969;5099.133147364957;5109.2080727486555;5116.360454943132;5125.666831655931;5158.200478925773;4690.319903613957;4738.336632871401;4740.834070807505;4743.478217396084;4793.161196790547;5644.209810626516;5724.914126288109;5725.227094342294;5732.885342293131;5774.451427114417;5510.669359838423;5520.558355331484;5521.751521181637;5529.917051244154;5533.087040638249;5539.7784088636;5589.524890384363;5660.830175094754;5733.512651424676;5740.167675686918;5415.323084614423;5477.75350109238;5484.341878974548;5492.258545096361;5547.916781248366;5451.918221226764;5504.779808807602;5510.448955104618;5527.640703354269;5538.944610554004;5298.8940221196135;5385.461453854583;5404.567634589302;5421.024215641065;5437.564994800486;5375.704336261543;5435.809746659006;5436.211749296409;5454.263674404064;5472.781088756406;5268.9736551317;5287.841364759063;5294;5295.232191332312;5349.144136938071;5340.519353258225;5368;5390.110631745718;5407.513323800877;5465.945340546544;5265.21021846726;5270.420253772006;5274.287971124003;5287.920681189708;5294 20:17:47 INFO - PROCESS | 30503 | |1;ext.html;521.2129684176895;534.9866253343666;541.5153437673282;549.3901769036371;555.1755642870338;27164.592531112048;27948.441031179365;27956;34766.65233347666;35404.82297588515;38368.61631383685;38884.80557597208;38916.61083389165;38944;38967.610323896755;8367.790805229857;8589;8590.140985901422;8590.742277731646;8591.398602097855;7348.5958272295;7531.887021694679;10016.499175041256;10209.89790102097;10218.846717299246;9987.700368988943;10049.598016079384;10096;10098.697039088838;10106.292559520836;7372;7516.473846830724;9969.850452243221;10070.546825392876;10079.748006299827;9693.273004524619;9863.161631261351;9873.40759554429;9876.160526355268;9882.160016398615;34828.12929676753;35749.82125089384;35839.641603584154;35856;36103.09742256438;3076.26169719268;3198.9040328789943;3221.371832492665;3516.4373700207843;3621.5835178954494;26610.20169394902;27191.320216994536;27413.725862741318;29008.12975610735;29318.267043323875;3992.7803970781597;4065.878023659265;4084.81618327176;4137.689673274486;4140.627343539066;278053;279095;279424;279628;280044;49570.50429495659;50523;55654;56980;57842.7107864458;54256.186157207674;54618.180727289124;54623;55010.72494637581;55055;15514.224288785741;15750.448734294245;15754.369825206863;15756.921215394079;15774.369025238862;12148;12181.33002684843;12219.450124744408;12237.143399962095;12310.630681079581;18293.176807043714;18296.359627412978;18413.171407286703;18470.630587388176;18620.16209270586;7108.822279443055;7271.600061996641;7306.305900939402;7311.268873112646;7378.852422951618;940.1256831146962;1015.6902144845893;1026.4252018869456;1100.1748688483638;1100.3452945497415;27907.72092279051;27917.30206744807;27979.160625181277;28152.310861348386;28488.857555712504;1022.4325499347784;1029.4029462911494;1049.0872940541624;1070.3363914373138;1142.0806250967885;13099.738005239842;13443.932780336232;13635.318234088454;13679.658008549866;13830.86169138316;314273;315470;317366;317538;317911;48504.7574762131;48806.511934880196;48834.755826220644;48914.51085489099;48959.755201223765;1321.2799024531462;1326.409747662281;1326.7545504081775;1347.9123856949268;1355.491690616019;25120.37199070038;25970.480590388463;26160;26194.476110478066;26260.474790504464;40536.3919541213;41065.58934410618;41321.173576528905;44509.55490445054;45446;233267;233987;234761;237133;237703;26335.4732905337;29111.272218194714;29423.85288073546;29490.557641635824;29512.852435737685;29845;32762;35782.105447362985;38347.80826095852;38463.230735384575;32203.838980804947;32669.18327041843;33134.66865331316;33291.16772080717;34932.47601286034;32994;34950.82524587361;35898.64101358953;35914.28171436609;36033.45949810807;34648.30703385969;34740.131496712784;34827.303453930275;35339.646603533634;35676.46485302774;28379.85810071019;30518.389632207676;31194.68805311918;31226.687733122377;31247.687523125387;23862.441212073438;24250.272491825275;24288;24329.635055474537;24510 20:17:47 INFO - PROCESS | 30503 | |2;jquery.html;349.3955457059287;352.42903022451213;354.25252716767613;357.6780897192528;357.737063258505;13859.307034648278;14235.78646320306;15900.761488577666;16014.279357428915;16688.33246670132;15871.206439677999;16116.194190290496;16901.49295521133;17230.913845430787;17254.2235599398;5406.783728650849;5500.559955203574;5506.091494903336;5511.063119269714;5513.255710479074;4027.7180597358197;4126.319157339036;5464.508194262516;5925.940740592603;6141.2937512186;6038.6074905131245;6053.818385448421;6056.273247210341;6060.030395136757;6081.939180608204;5245.554127899133;5397.568194544427;5398.784048638069;5406.351237851483;5408.783648654049;5095.668781529189;5184.844454666366;5197.168453047494;5202.06362854686;5237.816676416307;12957;13093.738125237538;13145.342732863319;13173.275469849155;20906.686399704016;2043.989780051105;2087.9060442280133;2124.919510624604;2145.0021450021413;2224.477247846755;9445.102715242041;9532.571034303473;9586.376885502421;9763.072508111789;9824.263180261509;1525.328855303674;1598.8321226271191;1699.2353440951497;1733.8352856478614;1819.5724004858848;58885;61039;61519.38480615226;61796.382036179515;62878.68560657167;9774.02259774017;9890.851637225447;9946.303758736964;9949.452780097165;10003.24975626831;13082.607521774362;13090.672733181747;13109.868901311056;13120.934395328153;13134.277614731282;7621.847563048708;7664.233576642291;7670.194629563927;7678.8080297993;7741.419393545507;7572.242775722384;7600.733974310872;7637.15991240963;7708.075030996316;7711.496258229704;4240.893977650583;4322.308430651144;4348.782560871944;4357.215701173819;4403.163398954189;1654.387876485708;1735.3232239426634;1746.7816522934634;1788.2578729826976;1801.2074687137617;886.8182022685334;928.2434815625244;999.0359303272377;1015.7404818025595;1077.8706555213425;16203.756943645854;16490.75263871043;16993.575160620836;17076.402325918534;17388.652226955644;913.794396260836;947.924166066713;963.8072385522923;987.8468837330225;1020.6474077252005;9259.76850578741;9488.478133702713;9685.854712179324;9900.257480688977;9976.501174941224;450268;470503;475351;480152;481185;60827.695861520406;67728.66135669389;69962.3003769966;70635.2936470639;71047;1064.0689396777818;1090.5310716392028;1091.3615534912008;1095.5891540672249;1125.9493322800495;12838.293893835555;14973.475928342456;15155.772663410278;15567.299471524035;15699.607509812346;30765;30854.53718194184;31570.210744731565;32545;33053.17367065843;37599;38634.42048369221;38671;40203;41857.581424185366;9404.38871473352;9443.716688499357;9604.807903842024;9612.51937403141;9644.662436814679;11467.139964502529;11583.710407239887;11649.825252621387;12719.745605088032;14148.858511415167;12532.310722910328;14137.858621413654;14157.858421415654;14511.201883896065;14662.853371466148;13983.580492585239;14203.431862725789;14390.568282951528;14465.78301325502;14547.272636367927;13833.515826946008;14072.718545628826;14284.785728214292;14546.272686365852;15003.399864005318;8886.4668119913;9366.765830854283;9401.529923503935;9406.858897116412;9597.568109434953;10426.791464170523;13885.305734713022;14482.903377344814;14907.701845962803;14914.552563423114 20:17:47 INFO - PROCESS | 30503 | |3;mootools.html;1257.704439456728;1414.7029123883985;1434.2971943747566;1564.8043994500688;1765.5409593505692;6591.439727623152;7161.677724502397;7295.343419092281;7305.452091093176;7320.853582928345;6990.335918087786;7122.679479423426;7132.821679458016;7134.143902731679;7148.249433809453;1902.781180164285;1938.7285779990812;1939.0886283446757;2204.691343211952;2238.1159442020476;2096.916123355064;2134.722486076808;2137.540428807806;2138.893055347234;2139.101577337522;2158.7085743424673;2163.9567208655817;2171.1966572368165;2174.4563859035243;2175.282156888231;1931.2371613212772;1957.080172319015;2189.255653077953;2194.3965409512352;2240.787125223101;2129.6273152198305;2165.6101901657694;2187.0049127646885;2188.9233876814237;2189.715337006195;7092.680829362691;7175.641217939082;7181.21006689269;7181.569105853613;7184.38932690722;4270.0605866709275;4335.479742430897;4342.609165175149;4346.087321662423;4346.76092814895;2826.406454644527;2879.452903948243;2902.100348891829;2919.605853209811;2927.985360073207;933.5332333833084;937.4515908193715;943.7216021273741;949.1457688080714;989.1443901025633;9528.904710952871;9654.420734755868;9670.75823104421;9677.274204434696;9727.61089556424;3859.286032084073;3945.585713500099;3998.4402183694306;4038.414429907647;4041.9191616167514;8457.40798144124;8478.025027121837;8483.44857584255;8494.53280069602;8504.192101750325;4431.8670439886855;4435.6673249505775;4448.532904045093;4470.664700147502;4473.329000649928;4040.474738284004;4068.044009657728;4089.6728261739586;4096.938545921814;4099.549049604541;3302.4716045432615;3417.8461969211444;3439.3465241604517;3441.587009558869;3446.3968805459444;1051.821190397619;1066.2056767707952;1069.04320633033;1070.3363914372983;1075.2097208551709;1282.2434763489587;1299.3633119771432;1330.4412146898326;1332.060897067565;1333.8466076401144;6141.293751218667;6588.8023359299295;6928.549644273106;6929.549579277331;6931.1682598088555;603.9818805435845;612.1552257884181;618.5731845027007;627.8399008252866;631.9936800632026;5358.30342055538;5366.329208848894;5370.597205209625;5373.462653734673;5389.784408623611;8064.919350806417;8174.182581741778;8291.33669306454;8300.833983320299;8314.293285070837;8140.104588495261;8148.837023259502;8196;8208.712695055645;8209.425340226246;6651.966740166268;6701.765438209639;6827.21487028998;6839.871421215543;6846.520743547904;6747.6626168692355;6749.156355455568;6756.054152418567;6762.797116086525;6828.112345395266;7682.231776822273;7822.100458447124;7835.3731701464885;7978.561179135203;8124.675012999413;7866.9213307866185;8118.472299300526;8160.183981601793;8215.260626543639;8224.136465671258;6282.905756413566;6287.528435367457;6363.427291543783;6406.711697973696;6407.807765767035;7043.190033146254;7096.2548932363425;7096.53872498286;7110.5022648414115;7119.572825630479;6600.141981542369;6654.700538475683;6674.766383176566;6751.392374686302;6848.9657551711925;6179.3820617937845;6545.803625891231;6548.148740663683;6552.24649165333;6611.371919667624;5699.116636921284;5780.797672081457;6073.271207455134;6098.908516372347;6109.69451527413;5623;5689.772409103755;5709.286339207599;5709.857253568528;5714.714264286852;5813.709314534341;5853.619514731528;5882.735276912464;5887.293524777054;5889.293284805851 20:17:47 INFO - PROCESS | 30503 | |4;prototype.html;332.81861385544875;339.1961052306035;341.8666719979207;342.05080900501116;351.4815646920792;5622.100463925773;5763.250777398937;5815.5638327125425;5816.854578635536;5852.151438041481;5524.447555244474;5673.461021202989;5679.545636349092;5679.914801277984;5718.628289161202;4456.153330867125;4476.709013914102;4481.551844815525;4483.103379324132;4491.618212451929;4272.230998420283;4344;4358.2808836541935;4458.331250312447;4486.528914463983;4409.11817636474;4412;4413.205622987861;4419.867403977886;4436.578525040132;4412.3602077698715;4414.757188354623;4421.182081314967;4424.269995450747;4441.644668426518;3949.782761948092;3952.446657467957;3958.980205098956;3959.8812035638975;3959.9010024749323;5375.596830237748;5414.675119492843;5473.370562385337;5476.26070480484;5500.7524661390335;5152.845414637567;5159.613029022838;5165.612579056548;5174.120399532088;5176.145935920568;6029.849253768647;6048.818535443944;6056;6065.727042283108;6068.059450785091;4351.151525452538;4352.042550638855;4352.2818734909015;4358.476982762058;4368.868933931987;5840.737166827503;5990.400959904018;6218.191635087455;6354.809355719336;6365.363463653597;4450.554944505524;4452.866414007585;4454.688171828006;4458.152950939311;4510.751908645056;4516.570925762047;4531.682782205214;4549.226631472658;4553.430821147356;4561.543845615478;5163.380394352626;5165;5169.4572069932865;5170.482951704799;5171.095058364846;5968.1644569760265;6098.908516372258;6118.571699980958;6120.449159575571;6123.38766123393;1583.6357637743383;1612.346999465195;1615.9596010099842;1617.3368918743258;1622.5456872075838;1100.6697990602788;1101.4052411697594;1101.8071837428417;1124.5558004588142;1124.7750449909888;5784.1034639630925;5795.623284486495;5832.650040997553;5843.824685259449;5847.210626565445;6050.152978582913;6195.19462469885;6209.441150296405;6273.404026617464;6290;5668.631538949955;5677.74450149736;5695.971520142372;5803.7968671096305;5832.154337621106;3371.477420999749;3387.0854869185673;3395.898123056312;3397.0997685613333;3402.3705614461405;6427.228732552124;6507.414332709984;6520.347965203442;6561.967190164114;6605.57063790852;6495.870082598416;6497.870042599122;6498.642574658439;6499.480041596661;6504.1869766279215;6589.17635295588;6592.967035164794;6596.505262105361;6600.570962887397;6608.240052394036;6175.413335733098;6295.622262664255;6309.589876658002;6310.684465776784;6314.368563143833;6211.751529938932;6252.749890004349;6253.937460625518;6257.843553911189;6261.24685088176;6573.769918052845;6576.967115164393;6582.111414958919;6590.308017658077;6591.242007169237;4452.1763473757455;4459.085887393012;4460.598546130864;4462.620677242471;4463.910721785611;6198.256209254918;6334.809955701337;6339.5562310637815;6346.524010699124;6349.460295874902;6125.908111378422;6179.196704428396;6180.825643127791;6181.938180618136;6186.1339412483185;6087.330393656605;6116.174316467398;6156.846078848064;6161.137440758387;6171.1668924694595;5892.646441213541;6048.213732214784;6057.333693293822;6066.696665166813;6113.449789518964;6217.96891015542;6221.626702397871;6233.065040244;6233.688315584293;6234.937650623617;6056.031035034373;6080.939190608037;6081.939180608138;6095.420935011344;6098.268207814913 20:17:47 INFO - PROCESS | 30503 | |5;yui.html;754.2909664914979;777.5995362388368;808.6280311056913;838.3335248477459;887.8623813308935;13373.7993930091;13566.525171618996;13608.251546164982;13616.795748063787;13625.250611216366;12488;12695.238285702864;12771.106022578424;12966.092373533857;13154.473821047171;812.6668066092889;812.7805492517047;821.1419067074892;821.195228675898;824.1881746479713;790.9367250619965;801.3709238247976;803.0604193094065;803.9879401808978;804.903411590607;840.4495055738471;848.6223630484437;850.6767428377208;851.3061854588491;851.8083431227986;844.1010324004915;844.923956843884;846.3102571404286;846.9534175620307;847;617.2099712368176;617.5954749638994;617.9938200618026;620.0265583034637;620.4106099205773;12383.19509231906;12484.938780203694;12554.74890502194;12615.558455454015;12630.49478020878;9872.45701486418;10088.89911100887;10239.692809215736;10433.947830260877;10793.352398856094;10014.298999070068;10075.89924100757;10130.442825644586;10150.9492452538;10505.2646314758;3549.94675079874;3604.8197590120653;3604.873829415958;3646.908827279339;3662.6703596676425;43213.35179972303;43951.560484395064;44265;44413.55586444127;44532.77733611344;6753.797386078426;9148.359614827032;10124.139448146843;10421.218408619385;10533.631322903662;18200.908995454938;18482.445526634223;18492.260309587466;18512;18537;7405.333519983227;7497.437692173;7622.9237707622215;7736;7849.254320839511;4443.333499974965;4445.888852778707;4448.132614140276;4500.504944456107;4543.863684089482;2929.516629756109;2939.030120060375;2958.5710072039433;2969.792114552004;2971.85140742962;529.6583703511213;540.6593845877151;546.2761840561272;552.4613501835678;563.0625009359453;571.7541457173372;618.981430557075;647.1499181167396;650.9967450162719;651.8728847874713;8264.421490495608;8542.871856922151;8571.614277357534;8641.654333826702;8793.164649358301;564.4863174511175;566.4533724955438;572.3719330156857;611.1596554737237;673.3300366135726;3820.5797362290127;3870.9419358709642;3922.37242041272;4041.312976793952;4116.629503344713;49436.75281623569;49609.75195124001;49856;50069;50484;46679.766601166775;48350.27474587884;48403;48507.757461212466;48627.513724863005;39219.60780392217;41381.37927931084;42318.36522452166;42655;45583.77208114004;7705.961470192613;7710.306072453506;7838.843223135619;7846.293833555007;7856.607169641381;33666.61334186518;34130.74973737523;34347.141321466166;34546.82726586351;34560.48159277563;36815.23885708636;38246.61753382542;38907.416388754755;44297;44845.775771120934;10851.348919064882;10897.945510272399;11024.834627480433;11122.61070862516;11214;11155;11301.208915376174;11314.094872410353;12003.879961200626;12070.84386962673;10052.497375131361;10126.44304563256;10136.543855526666;10238.232132590234;11005.669829905115;10584;10705.9464702676;10929.726756830825;11383.886161138282;11475.655730328104;10093.293469457067;10140.543675534765;10279.126274266771;10609.9469502652;10632.41521716313;9511.904880951102;9693.515324233902;9834;9944.701658950244;10618.256722029384;8395.968822915955;8699.521526316114;8998.910010899806;9043.231325337158;9754.414735115915 20:17:47 INFO - PROCESS | 30503 | __end_tp_report 20:17:47 INFO - PROCESS | 30503 | __start_cc_report 20:17:47 INFO - PROCESS | 30503 | _x_x_mozilla_cycle_collect,1085 20:17:47 INFO - PROCESS | 30503 | __end_cc_report 20:17:47 INFO - PROCESS | 30503 | __startTimestamp1452053867092__endTimestamp 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | ------- Summary: start ------- 20:17:47 INFO - PROCESS | 30503 | Number of tests: 6 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | [#0] dojo.html Cycles:165 Average:5121.09 Median:5294.00 stddev:538.61 (10.2%) stddev-sans-first:516.55 20:17:47 INFO - PROCESS | 30503 | Values: 3106.5 3157.7 3169.3 3201.5 3216.1 4961.8 5111.4 5119.0 5149.8 5181.1 5087.8 5098.1 5157.8 5169.4 5195.2 4675.2 4684.1 4684.9 4747.1 4772.1 4796.3 4799.8 4807.9 4851.4 4861.0 4647.7 4648.6 4722.7 4751.1 4772.2 4724.5 4732.6 4740.7 4755.6 4803.4 4615.6 4707.9 4713.0 4724.0 4764.3 4973.3 4980.6 5051.7 5070.3 5103.9 5470.5 5492.2 5493.9 5494.1 5497.9 5354.8 5501.0 5524.6 5527.0 5560.0 5052.1 5091.5 5105.5 5107.0 5159.9 5581.2 5657.5 5657.6 5658.3 5663.0 5295.5 5402.6 5413.2 5444.1 5473.7 5480.1 5558.3 5567.4 5569.9 5597.2 5460.6 5469.7 5471.3 5471.5 5472.1 5290.6 5407.4 5453.2 5462.5 5507.3 4292.6 4317.0 4317.9 4353.0 4379.1 3824.0 3849.4 3858.7 3875.9 3892.3 4952.6 5057.4 5059.1 5067.9 5085.3 5412.2 5473.5 5489.0 5490.1 5520.8 5099.1 5109.2 5116.4 5125.7 5158.2 4690.3 4738.3 4740.8 4743.5 4793.2 5644.2 5724.9 5725.2 5732.9 5774.5 5510.7 5520.6 5521.8 5529.9 5533.1 5539.8 5589.5 5660.8 5733.5 5740.2 5415.3 5477.8 5484.3 5492.3 5547.9 5451.9 5504.8 5510.4 5527.6 5538.9 5298.9 5385.5 5404.6 5421.0 5437.6 5375.7 5435.8 5436.2 5454.3 5472.8 5269.0 5287.8 5294.0 5295.2 5349.1 5340.5 5368.0 5390.1 5407.5 5465.9 5265.2 5270.4 5274.3 5287.9 5294.0 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | [#1] ext.html Cycles:180 Average:43486.35 Median:317452.00 stddev:72888.24 (23.0%) stddev-sans-first:73021.32 20:17:47 INFO - PROCESS | 30503 | Values: 521.2 535.0 541.5 549.4 555.2 27164.6 27948.4 27956.0 34766.7 35404.8 38368.6 38884.8 38916.6 38944.0 38967.6 8367.8 8589.0 8590.1 8590.7 8591.4 7348.6 7531.9 10016.5 10209.9 10218.8 9987.7 10049.6 10096.0 10098.7 10106.3 7372.0 7516.5 9969.9 10070.5 10079.7 9693.3 9863.2 9873.4 9876.2 9882.2 34828.1 35749.8 35839.6 35856.0 36103.1 3076.3 3198.9 3221.4 3516.4 3621.6 26610.2 27191.3 27413.7 29008.1 29318.3 3992.8 4065.9 4084.8 4137.7 4140.6 278053.0 279095.0 279424.0 279628.0 280044.0 49570.5 50523.0 55654.0 56980.0 57842.7 54256.2 54618.2 54623.0 55010.7 55055.0 15514.2 15750.4 15754.4 15756.9 15774.4 12148.0 12181.3 12219.5 12237.1 12310.6 18293.2 18296.4 18413.2 18470.6 18620.2 7108.8 7271.6 7306.3 7311.3 7378.9 940.1 1015.7 1026.4 1100.2 1100.3 27907.7 27917.3 27979.2 28152.3 28488.9 1022.4 1029.4 1049.1 1070.3 1142.1 13099.7 13443.9 13635.3 13679.7 13830.9 314273.0 315470.0 317366.0 317538.0 317911.0 48504.8 48806.5 48834.8 48914.5 48959.8 1321.3 1326.4 1326.8 1347.9 1355.5 25120.4 25970.5 26160.0 26194.5 26260.5 40536.4 41065.6 41321.2 44509.6 45446.0 233267.0 233987.0 234761.0 237133.0 237703.0 26335.5 29111.3 29423.9 29490.6 29512.9 29845.0 32762.0 35782.1 38347.8 38463.2 32203.8 32669.2 33134.7 33291.2 34932.5 32994.0 34950.8 35898.6 35914.3 36033.5 34648.3 34740.1 34827.3 35339.6 35676.5 28379.9 30518.4 31194.7 31226.7 31247.7 23862.4 24250.3 24288.0 24329.6 24510.0 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | [#2] jquery.html Cycles:180 Average:25999.44 Median:38652.71 stddev:76986.50 (199.2%) stddev-sans-first:77178.38 20:17:47 INFO - PROCESS | 30503 | Values: 349.4 352.4 354.3 357.7 357.7 13859.3 14235.8 15900.8 16014.3 16688.3 15871.2 16116.2 16901.5 17230.9 17254.2 5406.8 5500.6 5506.1 5511.1 5513.3 4027.7 4126.3 5464.5 5925.9 6141.3 6038.6 6053.8 6056.3 6060.0 6081.9 5245.6 5397.6 5398.8 5406.4 5408.8 5095.7 5184.8 5197.2 5202.1 5237.8 12957.0 13093.7 13145.3 13173.3 20906.7 2044.0 2087.9 2124.9 2145.0 2224.5 9445.1 9532.6 9586.4 9763.1 9824.3 1525.3 1598.8 1699.2 1733.8 1819.6 58885.0 61039.0 61519.4 61796.4 62878.7 9774.0 9890.9 9946.3 9949.5 10003.2 13082.6 13090.7 13109.9 13120.9 13134.3 7621.8 7664.2 7670.2 7678.8 7741.4 7572.2 7600.7 7637.2 7708.1 7711.5 4240.9 4322.3 4348.8 4357.2 4403.2 1654.4 1735.3 1746.8 1788.3 1801.2 886.8 928.2 999.0 1015.7 1077.9 16203.8 16490.8 16993.6 17076.4 17388.7 913.8 947.9 963.8 987.8 1020.6 9259.8 9488.5 9685.9 9900.3 9976.5 450268.0 470503.0 475351.0 480152.0 481185.0 60827.7 67728.7 69962.3 70635.3 71047.0 1064.1 1090.5 1091.4 1095.6 1125.9 12838.3 14973.5 15155.8 15567.3 15699.6 30765.0 30854.5 31570.2 32545.0 33053.2 37599.0 38634.4 38671.0 40203.0 41857.6 9404.4 9443.7 9604.8 9612.5 9644.7 11467.1 11583.7 11649.8 12719.7 14148.9 12532.3 14137.9 14157.9 14511.2 14662.9 13983.6 14203.4 14390.6 14465.8 14547.3 13833.5 14072.7 14284.8 14546.3 15003.4 8886.5 9366.8 9401.5 9406.9 9597.6 10426.8 13885.3 14482.9 14907.7 14914.6 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | [#3] mootools.html Cycles:180 Average:5025.24 Median:3360.92 stddev:2573.87 (76.6%) stddev-sans-first:2565.51 20:17:47 INFO - PROCESS | 30503 | Values: 1257.7 1414.7 1434.3 1564.8 1765.5 6591.4 7161.7 7295.3 7305.5 7320.9 6990.3 7122.7 7132.8 7134.1 7148.2 1902.8 1938.7 1939.1 2204.7 2238.1 2096.9 2134.7 2137.5 2138.9 2139.1 2158.7 2164.0 2171.2 2174.5 2175.3 1931.2 1957.1 2189.3 2194.4 2240.8 2129.6 2165.6 2187.0 2188.9 2189.7 7092.7 7175.6 7181.2 7181.6 7184.4 4270.1 4335.5 4342.6 4346.1 4346.8 2826.4 2879.5 2902.1 2919.6 2928.0 933.5 937.5 943.7 949.1 989.1 9528.9 9654.4 9670.8 9677.3 9727.6 3859.3 3945.6 3998.4 4038.4 4041.9 8457.4 8478.0 8483.4 8494.5 8504.2 4431.9 4435.7 4448.5 4470.7 4473.3 4040.5 4068.0 4089.7 4096.9 4099.5 3302.5 3417.8 3439.3 3441.6 3446.4 1051.8 1066.2 1069.0 1070.3 1075.2 1282.2 1299.4 1330.4 1332.1 1333.8 6141.3 6588.8 6928.5 6929.5 6931.2 604.0 612.2 618.6 627.8 632.0 5358.3 5366.3 5370.6 5373.5 5389.8 8064.9 8174.2 8291.3 8300.8 8314.3 8140.1 8148.8 8196.0 8208.7 8209.4 6652.0 6701.8 6827.2 6839.9 6846.5 6747.7 6749.2 6756.1 6762.8 6828.1 7682.2 7822.1 7835.4 7978.6 8124.7 7866.9 8118.5 8160.2 8215.3 8224.1 6282.9 6287.5 6363.4 6406.7 6407.8 7043.2 7096.3 7096.5 7110.5 7119.6 6600.1 6654.7 6674.8 6751.4 6849.0 6179.4 6545.8 6548.1 6552.2 6611.4 5699.1 5780.8 6073.3 6098.9 6109.7 5623.0 5689.8 5709.3 5709.9 5714.7 5813.7 5853.6 5882.7 5887.3 5889.3 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | [#4] prototype.html Cycles:180 Average:5136.19 Median:5789.86 stddev:1518.00 (26.2%) stddev-sans-first:1478.82 20:17:47 INFO - PROCESS | 30503 | Values: 332.8 339.2 341.9 342.1 351.5 5622.1 5763.3 5815.6 5816.9 5852.2 5524.4 5673.5 5679.5 5679.9 5718.6 4456.2 4476.7 4481.6 4483.1 4491.6 4272.2 4344.0 4358.3 4458.3 4486.5 4409.1 4412.0 4413.2 4419.9 4436.6 4412.4 4414.8 4421.2 4424.3 4441.6 3949.8 3952.4 3959.0 3959.9 3959.9 5375.6 5414.7 5473.4 5476.3 5500.8 5152.8 5159.6 5165.6 5174.1 5176.1 6029.8 6048.8 6056.0 6065.7 6068.1 4351.2 4352.0 4352.3 4358.5 4368.9 5840.7 5990.4 6218.2 6354.8 6365.4 4450.6 4452.9 4454.7 4458.2 4510.8 4516.6 4531.7 4549.2 4553.4 4561.5 5163.4 5165.0 5169.5 5170.5 5171.1 5968.2 6098.9 6118.6 6120.4 6123.4 1583.6 1612.3 1616.0 1617.3 1622.5 1100.7 1101.4 1101.8 1124.6 1124.8 5784.1 5795.6 5832.7 5843.8 5847.2 6050.2 6195.2 6209.4 6273.4 6290.0 5668.6 5677.7 5696.0 5803.8 5832.2 3371.5 3387.1 3395.9 3397.1 3402.4 6427.2 6507.4 6520.3 6562.0 6605.6 6495.9 6497.9 6498.6 6499.5 6504.2 6589.2 6593.0 6596.5 6600.6 6608.2 6175.4 6295.6 6309.6 6310.7 6314.4 6211.8 6252.7 6253.9 6257.8 6261.2 6573.8 6577.0 6582.1 6590.3 6591.2 4452.2 4459.1 4460.6 4462.6 4463.9 6198.3 6334.8 6339.6 6346.5 6349.5 6125.9 6179.2 6180.8 6181.9 6186.1 6087.3 6116.2 6156.8 6161.1 6171.2 5892.6 6048.2 6057.3 6066.7 6113.4 6218.0 6221.6 6233.1 6233.7 6234.9 6056.0 6080.9 6081.9 6095.4 6098.3 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - PROCESS | 30503 | [#5] yui.html Cycles:180 Average:12918.19 Median:4444.61 stddev:14504.47 (326.3%) stddev-sans-first:14516.39 20:17:47 INFO - PROCESS | 30503 | Values: 754.3 777.6 808.6 838.3 887.9 13373.8 13566.5 13608.3 13616.8 13625.3 12488.0 12695.2 12771.1 12966.1 13154.5 812.7 812.8 821.1 821.2 824.2 790.9 801.4 803.1 804.0 804.9 840.4 848.6 850.7 851.3 851.8 844.1 844.9 846.3 847.0 847.0 617.2 617.6 618.0 620.0 620.4 12383.2 12484.9 12554.7 12615.6 12630.5 9872.5 10088.9 10239.7 10433.9 10793.4 10014.3 10075.9 10130.4 10150.9 10505.3 3549.9 3604.8 3604.9 3646.9 3662.7 43213.4 43951.6 44265.0 44413.6 44532.8 6753.8 9148.4 10124.1 10421.2 10533.6 18200.9 18482.4 18492.3 18512.0 18537.0 7405.3 7497.4 7622.9 7736.0 7849.3 4443.3 4445.9 4448.1 4500.5 4543.9 2929.5 2939.0 2958.6 2969.8 2971.9 529.7 540.7 546.3 552.5 563.1 571.8 619.0 647.1 651.0 651.9 8264.4 8542.9 8571.6 8641.7 8793.2 564.5 566.5 572.4 611.2 673.3 3820.6 3870.9 3922.4 4041.3 4116.6 49436.8 49609.8 49856.0 50069.0 50484.0 46679.8 48350.3 48403.0 48507.8 48627.5 39219.6 41381.4 42318.4 42655.0 45583.8 7706.0 7710.3 7838.8 7846.3 7856.6 33666.6 34130.7 34347.1 34546.8 34560.5 36815.2 38246.6 38907.4 44297.0 44845.8 10851.3 10897.9 11024.8 11122.6 11214.0 11155.0 11301.2 11314.1 12003.9 12070.8 10052.5 10126.4 10136.5 10238.2 11005.7 10584.0 10705.9 10929.7 11383.9 11475.7 10093.3 10140.5 10279.1 10609.9 10632.4 9511.9 9693.5 9834.0 9944.7 10618.3 8396.0 8699.5 8998.9 9043.2 9754.4 20:17:47 INFO - PROCESS | 30503 | -------- Summary: end -------- 20:17:47 INFO - PROCESS | 30503 | 20:17:47 INFO - TEST-INFO | 30503: exit 0 20:17:47 INFO - TEST-OK | dromaeo_css | took 1112546ms 20:17:47 INFO - TEST-START | kraken 20:17:47 INFO - operating with platform_type : linux_ 20:17:47 INFO - Initialising browser for kraken test... 20:17:47 INFO - TEST-INFO | started process 30699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqbIgHv/profile http://localhost:44496/getInfo.html) 20:17:51 INFO - PROCESS | 30699 | __metrics Screen width/height:1600/1200 20:17:51 INFO - PROCESS | 30699 | colorDepth:24 20:17:51 INFO - PROCESS | 30699 | Browser inner width/height: 1024/697 20:17:51 INFO - PROCESS | 30699 | __metrics 20:17:51 INFO - PROCESS | 30699 | 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:17:51 INFO - PROCESS | 30699 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:51 INFO - PROCESS | 30699 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:17:52 INFO - TEST-INFO | 30699: exit 0 20:17:52 INFO - Browser initialized. 20:17:52 INFO - Running cycle 1/1 for kraken test... 20:17:52 INFO - TEST-INFO | started process 30785 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqbIgHv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:04 INFO - PROCESS | 30785 | RSS: Main: 147664896 20:18:04 INFO - PROCESS | 30785 | 20:18:06 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44496/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:07 INFO - PROCESS | 30785 | RSS: Main: 183365632 20:18:07 INFO - PROCESS | 30785 | 20:18:09 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44496/tests/kraken/driver.html?testName=audio-dft) 20:18:10 INFO - PROCESS | 30785 | RSS: Main: 171601920 20:18:10 INFO - PROCESS | 30785 | 20:18:13 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44496/tests/kraken/driver.html?testName=audio-fft) 20:18:13 INFO - PROCESS | 30785 | RSS: Main: 158912512 20:18:13 INFO - PROCESS | 30785 | 20:18:15 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44496/tests/kraken/driver.html?testName=audio-oscillator) 20:18:16 INFO - PROCESS | 30785 | RSS: Main: 160567296 20:18:16 INFO - PROCESS | 30785 | 20:18:18 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:19 INFO - PROCESS | 30785 | RSS: Main: 162160640 20:18:19 INFO - PROCESS | 30785 | 20:18:22 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44496/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:22 INFO - PROCESS | 30785 | RSS: Main: 162263040 20:18:22 INFO - PROCESS | 30785 | 20:18:26 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44496/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:26 INFO - PROCESS | 30785 | RSS: Main: 163700736 20:18:26 INFO - PROCESS | 30785 | 20:18:29 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44496/tests/kraken/driver.html?testName=json-parse-financial) 20:18:29 INFO - PROCESS | 30785 | RSS: Main: 161574912 20:18:29 INFO - PROCESS | 30785 | 20:18:31 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:32 INFO - PROCESS | 30785 | RSS: Main: 173420544 20:18:32 INFO - PROCESS | 30785 | 20:18:33 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:34 INFO - PROCESS | 30785 | RSS: Main: 170590208 20:18:34 INFO - PROCESS | 30785 | 20:18:36 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:37 INFO - PROCESS | 30785 | RSS: Main: 178495488 20:18:37 INFO - PROCESS | 30785 | 20:18:39 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:40 INFO - PROCESS | 30785 | RSS: Main: 188174336 20:18:40 INFO - PROCESS | 30785 | 20:18:42 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:43 INFO - PROCESS | 30785 | RSS: Main: 187625472 20:18:43 INFO - PROCESS | 30785 | 20:18:44 INFO - PROCESS | 30785 | Cycle 1(1): loaded http://localhost:44496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44496/tests/kraken/driver.html?testName=ai-astar) 20:18:45 INFO - PROCESS | 30785 | RSS: Main: 244178944 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | __start_tp_report 20:18:45 INFO - PROCESS | 30785 | _x_x_mozilla_page_load 20:18:45 INFO - PROCESS | 30785 | _x_x_mozilla_page_load_details 20:18:45 INFO - PROCESS | 30785 | |i|pagename|runs| 20:18:45 INFO - PROCESS | 30785 | |0;ai-astar;110;112;104;110;112;110;101;110;110;112 20:18:45 INFO - PROCESS | 30785 | |1;audio-beat-detection;156;123;149;165;132;156;151;134;158;124 20:18:45 INFO - PROCESS | 30785 | |2;audio-dft;163;160;160;161;159;160;160;162;161;162 20:18:45 INFO - PROCESS | 30785 | |3;audio-fft;74;75;86;93;71;71;74;105;90;72 20:18:45 INFO - PROCESS | 30785 | |4;audio-oscillator;97;97;143;96;97;97;137;96;97;137 20:18:45 INFO - PROCESS | 30785 | |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;109 20:18:45 INFO - PROCESS | 30785 | |6;imaging-darkroom;146;146;145;145;144;146;145;144;145;145 20:18:45 INFO - PROCESS | 30785 | |7;imaging-desaturate;95;95;96;96;95;96;96;96;96;96 20:18:45 INFO - PROCESS | 30785 | |8;json-parse-financial;60;58;59;68;59;60;60;63;61;57 20:18:45 INFO - PROCESS | 30785 | |9;json-stringify-tinderbox;68;68;68;66;68;68;68;67;68;67 20:18:45 INFO - PROCESS | 30785 | |10;stanford-crypto-aes;84;86;86;85;85;86;86;85;89;87 20:18:45 INFO - PROCESS | 30785 | |11;stanford-crypto-ccm;124;118;119;116;123;127;127;122;115;117 20:18:45 INFO - PROCESS | 30785 | |12;stanford-crypto-pbkdf2;151;143;154;158;156;146;160;153;159;157 20:18:45 INFO - PROCESS | 30785 | |13;stanford-crypto-sha256-iterative;72;68;70;69;68;68;69;68;68;69 20:18:45 INFO - PROCESS | 30785 | __end_tp_report 20:18:45 INFO - PROCESS | 30785 | __start_cc_report 20:18:45 INFO - PROCESS | 30785 | _x_x_mozilla_cycle_collect,932 20:18:45 INFO - PROCESS | 30785 | __end_cc_report 20:18:45 INFO - PROCESS | 30785 | __startTimestamp1452053925244__endTimestamp 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | ------- Summary: start ------- 20:18:45 INFO - PROCESS | 30785 | Number of tests: 14 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.67 (3.3%) stddev-sans-first:3.87 20:18:45 INFO - PROCESS | 30785 | Values: 110.0 112.0 104.0 110.0 112.0 110.0 101.0 110.0 110.0 112.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:153.50 stddev:15.19 (9.9%) stddev-sans-first:15.57 20:18:45 INFO - PROCESS | 30785 | Values: 156.0 123.0 149.0 165.0 132.0 156.0 151.0 134.0 158.0 124.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.01 20:18:45 INFO - PROCESS | 30785 | Values: 163.0 160.0 160.0 161.0 159.0 160.0 160.0 162.0 161.0 162.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:11.74 (15.8%) stddev-sans-first:12.17 20:18:45 INFO - PROCESS | 30785 | Values: 74.0 75.0 86.0 93.0 71.0 71.0 74.0 105.0 90.0 72.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:97.00 stddev:20.49 (21.1%) stddev-sans-first:21.24 20:18:45 INFO - PROCESS | 30785 | Values: 97.0 97.0 143.0 96.0 97.0 97.0 137.0 96.0 97.0 137.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:18:45 INFO - PROCESS | 30785 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 20:18:45 INFO - PROCESS | 30785 | Values: 146.0 146.0 145.0 145.0 144.0 146.0 145.0 144.0 145.0 145.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:18:45 INFO - PROCESS | 30785 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:60.00 stddev:3.10 (5.2%) stddev-sans-first:3.28 20:18:45 INFO - PROCESS | 30785 | Values: 60.0 58.0 59.0 68.0 59.0 60.0 60.0 63.0 61.0 57.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 20:18:45 INFO - PROCESS | 30785 | Values: 68.0 68.0 68.0 66.0 68.0 68.0 68.0 67.0 68.0 67.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.37 (1.6%) stddev-sans-first:1.27 20:18:45 INFO - PROCESS | 30785 | Values: 84.0 86.0 86.0 85.0 85.0 86.0 86.0 85.0 89.0 87.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.50 stddev:4.42 (3.6%) stddev-sans-first:4.53 20:18:45 INFO - PROCESS | 30785 | Values: 124.0 118.0 119.0 116.0 123.0 127.0 127.0 122.0 115.0 117.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:156.50 stddev:5.62 (3.6%) stddev-sans-first:5.87 20:18:45 INFO - PROCESS | 30785 | Values: 151.0 143.0 154.0 158.0 156.0 146.0 160.0 153.0 159.0 157.0 20:18:45 INFO - PROCESS | 30785 | 20:18:45 INFO - PROCESS | 30785 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:0.73 20:18:45 INFO - PROCESS | 30785 | Values: 72.0 68.0 70.0 69.0 68.0 68.0 69.0 68.0 68.0 69.0 20:18:45 INFO - PROCESS | 30785 | -------- Summary: end -------- 20:18:45 INFO - PROCESS | 30785 | 20:18:46 INFO - TEST-INFO | 30785: exit 0 20:18:46 INFO - TEST-OK | kraken | took 58400ms 20:18:46 INFO - TEST-START | v8_7 20:18:46 INFO - operating with platform_type : linux_ 20:18:46 INFO - Initialising browser for v8_7 test... 20:18:46 INFO - TEST-INFO | started process 31035 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYmp8Bm/profile http://localhost:44496/getInfo.html) 20:18:49 INFO - PROCESS | 31035 | __metrics Screen width/height:1600/1200 20:18:49 INFO - PROCESS | 31035 | colorDepth:24 20:18:49 INFO - PROCESS | 31035 | Browser inner width/height: 1024/697 20:18:49 INFO - PROCESS | 31035 | __metrics 20:18:49 INFO - PROCESS | 31035 | 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:18:49 INFO - PROCESS | 31035 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:50 INFO - TEST-INFO | 31035: exit 0 20:18:50 INFO - Browser initialized. 20:18:50 INFO - Running cycle 1/1 for v8_7 test... 20:18:50 INFO - TEST-INFO | started process 31121 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYmp8Bm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:02 INFO - PROCESS | 31121 | RSS: Main: 149651456 20:19:02 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | Cycle 1(1): loaded http://localhost:44496/tests/v8_7/run.html (next: http://localhost:44496/tests/v8_7/run.html) 20:19:24 INFO - PROCESS | 31121 | RSS: Main: 587251712 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | __start_tp_report 20:19:24 INFO - PROCESS | 31121 | _x_x_mozilla_page_load 20:19:24 INFO - PROCESS | 31121 | _x_x_mozilla_page_load_details 20:19:24 INFO - PROCESS | 31121 | |i|pagename|runs| 20:19:24 INFO - PROCESS | 31121 | |0;Richards;171.32088401576152 20:19:24 INFO - PROCESS | 31121 | |1;DeltaBlue;197.12201852946976 20:19:24 INFO - PROCESS | 31121 | |2;Encrypt;283.60748723766307 20:19:24 INFO - PROCESS | 31121 | |3;Decrypt;5164.948453608247 20:19:24 INFO - PROCESS | 31121 | |4;RayTrace;1937.984496124031 20:19:24 INFO - PROCESS | 31121 | |5;Earley;797.4481658692185 20:19:24 INFO - PROCESS | 31121 | |6;Boyer;11941.176470588236 20:19:24 INFO - PROCESS | 31121 | |7;RegExp;26128.20512820513 20:19:24 INFO - PROCESS | 31121 | |8;Splay;655.7591623036649 20:19:24 INFO - PROCESS | 31121 | |9;NavierStokes;4840.579710144928 20:19:24 INFO - PROCESS | 31121 | __end_tp_report 20:19:24 INFO - PROCESS | 31121 | __startTimestamp1452053964394__endTimestamp 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | ------- Summary: start ------- 20:19:24 INFO - PROCESS | 31121 | Number of tests: 10 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#0] Richards Cycles:1 Average:171.32 Median:171.32 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 171.3 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#1] DeltaBlue Cycles:1 Average:197.12 Median:197.12 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 197.1 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#2] Encrypt Cycles:1 Average:283.61 Median:283.61 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 283.6 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 5164.9 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#4] RayTrace Cycles:1 Average:1937.98 Median:1937.98 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 1938.0 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 797.4 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#6] Boyer Cycles:1 Average:11941.18 Median:11941.18 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 11941.2 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 26128.2 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#8] Splay Cycles:1 Average:655.76 Median:655.76 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 655.8 20:19:24 INFO - PROCESS | 31121 | 20:19:24 INFO - PROCESS | 31121 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:19:24 INFO - PROCESS | 31121 | Values: 4840.6 20:19:24 INFO - PROCESS | 31121 | -------- Summary: end -------- 20:19:24 INFO - PROCESS | 31121 | 20:19:25 INFO - TEST-INFO | 31121: exit 0 20:19:25 INFO - TEST-OK | v8_7 | took 39095ms 20:19:25 INFO - SUITE-END | took 1210s 20:19:25 INFO - Completed test suite (00:20:10) 20:19:25 INFO - Working with test: dromaeo_css 20:19:25 INFO - Generating results file: dromaeo_css 20:19:25 INFO - Working with test: kraken 20:19:25 INFO - Generating results file: kraken 20:19:25 INFO - javascript benchmark 20:19:25 INFO - Working with test: v8_7 20:19:25 INFO - Generating results file: v8_7 20:19:25 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:19:25 INFO - process_Request line: dromaeo_css 6688.12 graph.html#tests=[[72,64,35]] 20:19:25 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:25 INFO - process_Request line: kraken 1512.50 graph.html#tests=[[232,64,35]] 20:19:25 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:25 INFO - process_Request line: v8_7 19564.70 graph.html#tests=[[230,64,35]] 20:19:25 INFO - RETURN: dromaeo_css: 6688.12 20:19:25 INFO - RETURN: kraken: 1512.50 20:19:25 INFO - RETURN: v8_7: 19564.70 20:19:25 INFO - javascript benchmark 20:19:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3106.4874295741197, 3157.731592814611, 3169.2710676544407, 3201.503766916129, 3216.0673404712634, 4961.776720047597, 5111.361079865017, 5119.0, 5149.794008239666, 5181.067407866587, 5087.821926232583, 5098.133317336053, 5157.819476318329, 5169.379674439063, 5195.19474481455, 4675.181843177447, 4684.1334353144775, 4684.906301873961, 4747.121782470237, 4772.141014617368, 4796.280557916306, 4799.832005879794, 4807.903841923159, 4851.417829860422, 4861.003494283681, 4647.697899636512, 4648.558386953234, 4722.7402492862875, 4751.073540659573, 4772.164871147553, 4724.480307166209, 4732.597729193023, 4740.691855029412, 4755.595774359183, 4803.423589169287, 4615.607673347769, 4707.882302942419, 4712.986707857827, 4723.976380118077, 4764.285357196413, 4973.3286006389035, 4980.626453016038, 5051.696898186121, 5070.264811602334, 5103.923441148386, 5470.452954704538, 5492.176173573956, 5493.917591236134, 5494.148406996922, 5497.890042199174, 5354.812581559666, 5501.0098182327165, 5524.558035357162, 5527.032769265363, 5559.999200143972, 5052.1411360068505, 5091.490850914916, 5105.463926287761, 5106.974465127688, 5159.922601160985, 5581.162825576196, 5657.4908258256955, 5657.57568182388, 5658.264425624642, 5663.0, 5295.549878260314, 5402.648827826179, 5413.215083812904, 5444.1017232156255, 5473.726313684379, 5480.068388373986, 5558.305211848519, 5567.387587365387, 5569.944300557024, 5597.160425936142, 5460.6177567569885, 5469.671819690831, 5471.316085489314, 5471.452854714496, 5472.124460086367, 5290.603204759582, 5407.351117865803, 5453.15476101205, 5462.453754624586, 5507.284053073155, 4292.613664770123, 4317.0, 4317.935230971538, 4353.020570371641, 4379.080393117417, 3823.9808800955816, 3849.4225866120305, 3858.6913046956174, 3875.903102422462, 3892.2799282132896, 4952.62855285855, 5057.443681195065, 5059.114654935372, 5067.949320506821, 5085.288059671649, 5412.188171774265, 5473.534749546254, 5489.0, 5490.066688662937, 5520.806771762969, 5099.133147364957, 5109.2080727486555, 5116.360454943132, 5125.666831655931, 5158.200478925773, 4690.319903613957, 4738.336632871401, 4740.834070807505, 4743.478217396084, 4793.161196790547, 5644.209810626516, 5724.914126288109, 5725.227094342294, 5732.885342293131, 5774.451427114417, 5510.669359838423, 5520.558355331484, 5521.751521181637, 5529.917051244154, 5533.087040638249, 5539.7784088636, 5589.524890384363, 5660.830175094754, 5733.512651424676, 5740.167675686918, 5415.323084614423, 5477.75350109238, 5484.341878974548, 5492.258545096361, 5547.916781248366, 5451.918221226764, 5504.779808807602, 5510.448955104618, 5527.640703354269, 5538.944610554004, 5298.8940221196135, 5385.461453854583, 5404.567634589302, 5421.024215641065, 5437.564994800486, 5375.704336261543, 5435.809746659006, 5436.211749296409, 5454.263674404064, 5472.781088756406, 5268.9736551317, 5287.841364759063, 5294.0, 5295.232191332312, 5349.144136938071, 5340.519353258225, 5368.0, 5390.110631745718, 5407.513323800877, 5465.945340546544, 5265.21021846726, 5270.420253772006, 5274.287971124003, 5287.920681189708, 5294.0], "unit": "score", "name": "dojo.html", "value": 5088.276141966815}, {"lowerIsBetter": false, "replicates": [521.2129684176895, 534.9866253343666, 541.5153437673282, 549.3901769036371, 555.1755642870338, 27164.592531112048, 27948.441031179365, 27956.0, 34766.65233347666, 35404.82297588515, 38368.61631383685, 38884.80557597208, 38916.61083389165, 38944.0, 38967.610323896755, 8367.790805229857, 8589.0, 8590.140985901422, 8590.742277731646, 8591.398602097855, 7348.5958272295, 7531.887021694679, 10016.499175041256, 10209.89790102097, 10218.846717299246, 9987.700368988943, 10049.598016079384, 10096.0, 10098.697039088838, 10106.292559520836, 7372.0, 7516.473846830724, 9969.850452243221, 10070.546825392876, 10079.748006299827, 9693.273004524619, 9863.161631261351, 9873.40759554429, 9876.160526355268, 9882.160016398615, 34828.12929676753, 35749.82125089384, 35839.641603584154, 35856.0, 36103.09742256438, 3076.26169719268, 3198.9040328789943, 3221.371832492665, 3516.4373700207843, 3621.5835178954494, 26610.20169394902, 27191.320216994536, 27413.725862741318, 29008.12975610735, 29318.267043323875, 3992.7803970781597, 4065.878023659265, 4084.81618327176, 4137.689673274486, 4140.627343539066, 278053.0, 279095.0, 279424.0, 279628.0, 280044.0, 49570.50429495659, 50523.0, 55654.0, 56980.0, 57842.7107864458, 54256.186157207674, 54618.180727289124, 54623.0, 55010.72494637581, 55055.0, 15514.224288785741, 15750.448734294245, 15754.369825206863, 15756.921215394079, 15774.369025238862, 12148.0, 12181.33002684843, 12219.450124744408, 12237.143399962095, 12310.630681079581, 18293.176807043714, 18296.359627412978, 18413.171407286703, 18470.630587388176, 18620.16209270586, 7108.822279443055, 7271.600061996641, 7306.305900939402, 7311.268873112646, 7378.852422951618, 940.1256831146962, 1015.6902144845893, 1026.4252018869456, 1100.1748688483638, 1100.3452945497415, 27907.72092279051, 27917.30206744807, 27979.160625181277, 28152.310861348386, 28488.857555712504, 1022.4325499347784, 1029.4029462911494, 1049.0872940541624, 1070.3363914373138, 1142.0806250967885, 13099.738005239842, 13443.932780336232, 13635.318234088454, 13679.658008549866, 13830.86169138316, 314273.0, 315470.0, 317366.0, 317538.0, 317911.0, 48504.7574762131, 48806.511934880196, 48834.755826220644, 48914.51085489099, 48959.755201223765, 1321.2799024531462, 1326.409747662281, 1326.7545504081775, 1347.9123856949268, 1355.491690616019, 25120.37199070038, 25970.480590388463, 26160.0, 26194.476110478066, 26260.474790504464, 40536.3919541213, 41065.58934410618, 41321.173576528905, 44509.55490445054, 45446.0, 233267.0, 233987.0, 234761.0, 237133.0, 237703.0, 26335.4732905337, 29111.272218194714, 29423.85288073546, 29490.557641635824, 29512.852435737685, 29845.0, 32762.0, 35782.105447362985, 38347.80826095852, 38463.230735384575, 32203.838980804947, 32669.18327041843, 33134.66865331316, 33291.16772080717, 34932.47601286034, 32994.0, 34950.82524587361, 35898.64101358953, 35914.28171436609, 36033.45949810807, 34648.30703385969, 34740.131496712784, 34827.303453930275, 35339.646603533634, 35676.46485302774, 28379.85810071019, 30518.389632207676, 31194.68805311918, 31226.687733122377, 31247.687523125387, 23862.441212073438, 24250.272491825275, 24288.0, 24329.635055474537, 24510.0], "unit": "score", "name": "ext.html", "value": 17720.395063696116}, {"lowerIsBetter": false, "replicates": [349.3955457059287, 352.42903022451213, 354.25252716767613, 357.6780897192528, 357.737063258505, 13859.307034648278, 14235.78646320306, 15900.761488577666, 16014.279357428915, 16688.33246670132, 15871.206439677999, 16116.194190290496, 16901.49295521133, 17230.913845430787, 17254.2235599398, 5406.783728650849, 5500.559955203574, 5506.091494903336, 5511.063119269714, 5513.255710479074, 4027.7180597358197, 4126.319157339036, 5464.508194262516, 5925.940740592603, 6141.2937512186, 6038.6074905131245, 6053.818385448421, 6056.273247210341, 6060.030395136757, 6081.939180608204, 5245.554127899133, 5397.568194544427, 5398.784048638069, 5406.351237851483, 5408.783648654049, 5095.668781529189, 5184.844454666366, 5197.168453047494, 5202.06362854686, 5237.816676416307, 12957.0, 13093.738125237538, 13145.342732863319, 13173.275469849155, 20906.686399704016, 2043.989780051105, 2087.9060442280133, 2124.919510624604, 2145.0021450021413, 2224.477247846755, 9445.102715242041, 9532.571034303473, 9586.376885502421, 9763.072508111789, 9824.263180261509, 1525.328855303674, 1598.8321226271191, 1699.2353440951497, 1733.8352856478614, 1819.5724004858848, 58885.0, 61039.0, 61519.38480615226, 61796.382036179515, 62878.68560657167, 9774.02259774017, 9890.851637225447, 9946.303758736964, 9949.452780097165, 10003.24975626831, 13082.607521774362, 13090.672733181747, 13109.868901311056, 13120.934395328153, 13134.277614731282, 7621.847563048708, 7664.233576642291, 7670.194629563927, 7678.8080297993, 7741.419393545507, 7572.242775722384, 7600.733974310872, 7637.15991240963, 7708.075030996316, 7711.496258229704, 4240.893977650583, 4322.308430651144, 4348.782560871944, 4357.215701173819, 4403.163398954189, 1654.387876485708, 1735.3232239426634, 1746.7816522934634, 1788.2578729826976, 1801.2074687137617, 886.8182022685334, 928.2434815625244, 999.0359303272377, 1015.7404818025595, 1077.8706555213425, 16203.756943645854, 16490.75263871043, 16993.575160620836, 17076.402325918534, 17388.652226955644, 913.794396260836, 947.924166066713, 963.8072385522923, 987.8468837330225, 1020.6474077252005, 9259.76850578741, 9488.478133702713, 9685.854712179324, 9900.257480688977, 9976.501174941224, 450268.0, 470503.0, 475351.0, 480152.0, 481185.0, 60827.695861520406, 67728.66135669389, 69962.3003769966, 70635.2936470639, 71047.0, 1064.0689396777818, 1090.5310716392028, 1091.3615534912008, 1095.5891540672249, 1125.9493322800495, 12838.293893835555, 14973.475928342456, 15155.772663410278, 15567.299471524035, 15699.607509812346, 30765.0, 30854.53718194184, 31570.210744731565, 32545.0, 33053.17367065843, 37599.0, 38634.42048369221, 38671.0, 40203.0, 41857.581424185366, 9404.38871473352, 9443.716688499357, 9604.807903842024, 9612.51937403141, 9644.662436814679, 11467.139964502529, 11583.710407239887, 11649.825252621387, 12719.745605088032, 14148.858511415167, 12532.310722910328, 14137.858621413654, 14157.858421415654, 14511.201883896065, 14662.853371466148, 13983.580492585239, 14203.431862725789, 14390.568282951528, 14465.78301325502, 14547.272636367927, 13833.515826946008, 14072.718545628826, 14284.785728214292, 14546.272686365852, 15003.399864005318, 8886.4668119913, 9366.765830854283, 9401.529923503935, 9406.858897116412, 9597.568109434953, 10426.791464170523, 13885.305734713022, 14482.903377344814, 14907.701845962803, 14914.552563423114], "unit": "score", "name": "jquery.html", "value": 8535.787208174252}, {"lowerIsBetter": false, "replicates": [1257.704439456728, 1414.7029123883985, 1434.2971943747566, 1564.8043994500688, 1765.5409593505692, 6591.439727623152, 7161.677724502397, 7295.343419092281, 7305.452091093176, 7320.853582928345, 6990.335918087786, 7122.679479423426, 7132.821679458016, 7134.143902731679, 7148.249433809453, 1902.781180164285, 1938.7285779990812, 1939.0886283446757, 2204.691343211952, 2238.1159442020476, 2096.916123355064, 2134.722486076808, 2137.540428807806, 2138.893055347234, 2139.101577337522, 2158.7085743424673, 2163.9567208655817, 2171.1966572368165, 2174.4563859035243, 2175.282156888231, 1931.2371613212772, 1957.080172319015, 2189.255653077953, 2194.3965409512352, 2240.787125223101, 2129.6273152198305, 2165.6101901657694, 2187.0049127646885, 2188.9233876814237, 2189.715337006195, 7092.680829362691, 7175.641217939082, 7181.21006689269, 7181.569105853613, 7184.38932690722, 4270.0605866709275, 4335.479742430897, 4342.609165175149, 4346.087321662423, 4346.76092814895, 2826.406454644527, 2879.452903948243, 2902.100348891829, 2919.605853209811, 2927.985360073207, 933.5332333833084, 937.4515908193715, 943.7216021273741, 949.1457688080714, 989.1443901025633, 9528.904710952871, 9654.420734755868, 9670.75823104421, 9677.274204434696, 9727.61089556424, 3859.286032084073, 3945.585713500099, 3998.4402183694306, 4038.414429907647, 4041.9191616167514, 8457.40798144124, 8478.025027121837, 8483.44857584255, 8494.53280069602, 8504.192101750325, 4431.8670439886855, 4435.6673249505775, 4448.532904045093, 4470.664700147502, 4473.329000649928, 4040.474738284004, 4068.044009657728, 4089.6728261739586, 4096.938545921814, 4099.549049604541, 3302.4716045432615, 3417.8461969211444, 3439.3465241604517, 3441.587009558869, 3446.3968805459444, 1051.821190397619, 1066.2056767707952, 1069.04320633033, 1070.3363914372983, 1075.2097208551709, 1282.2434763489587, 1299.3633119771432, 1330.4412146898326, 1332.060897067565, 1333.8466076401144, 6141.293751218667, 6588.8023359299295, 6928.549644273106, 6929.549579277331, 6931.1682598088555, 603.9818805435845, 612.1552257884181, 618.5731845027007, 627.8399008252866, 631.9936800632026, 5358.30342055538, 5366.329208848894, 5370.597205209625, 5373.462653734673, 5389.784408623611, 8064.919350806417, 8174.182581741778, 8291.33669306454, 8300.833983320299, 8314.293285070837, 8140.104588495261, 8148.837023259502, 8196.0, 8208.712695055645, 8209.425340226246, 6651.966740166268, 6701.765438209639, 6827.21487028998, 6839.871421215543, 6846.520743547904, 6747.6626168692355, 6749.156355455568, 6756.054152418567, 6762.797116086525, 6828.112345395266, 7682.231776822273, 7822.100458447124, 7835.3731701464885, 7978.561179135203, 8124.675012999413, 7866.9213307866185, 8118.472299300526, 8160.183981601793, 8215.260626543639, 8224.136465671258, 6282.905756413566, 6287.528435367457, 6363.427291543783, 6406.711697973696, 6407.807765767035, 7043.190033146254, 7096.2548932363425, 7096.53872498286, 7110.5022648414115, 7119.572825630479, 6600.141981542369, 6654.700538475683, 6674.766383176566, 6751.392374686302, 6848.9657551711925, 6179.3820617937845, 6545.803625891231, 6548.148740663683, 6552.24649165333, 6611.371919667624, 5699.116636921284, 5780.797672081457, 6073.271207455134, 6098.908516372347, 6109.69451527413, 5623.0, 5689.772409103755, 5709.286339207599, 5709.857253568528, 5714.714264286852, 5813.709314534341, 5853.619514731528, 5882.735276912464, 5887.293524777054, 5889.293284805851], "unit": "score", "name": "mootools.html", "value": 4118.2542563126035}, {"lowerIsBetter": false, "replicates": [332.81861385544875, 339.1961052306035, 341.8666719979207, 342.05080900501116, 351.4815646920792, 5622.100463925773, 5763.250777398937, 5815.5638327125425, 5816.854578635536, 5852.151438041481, 5524.447555244474, 5673.461021202989, 5679.545636349092, 5679.914801277984, 5718.628289161202, 4456.153330867125, 4476.709013914102, 4481.551844815525, 4483.103379324132, 4491.618212451929, 4272.230998420283, 4344.0, 4358.2808836541935, 4458.331250312447, 4486.528914463983, 4409.11817636474, 4412.0, 4413.205622987861, 4419.867403977886, 4436.578525040132, 4412.3602077698715, 4414.757188354623, 4421.182081314967, 4424.269995450747, 4441.644668426518, 3949.782761948092, 3952.446657467957, 3958.980205098956, 3959.8812035638975, 3959.9010024749323, 5375.596830237748, 5414.675119492843, 5473.370562385337, 5476.26070480484, 5500.7524661390335, 5152.845414637567, 5159.613029022838, 5165.612579056548, 5174.120399532088, 5176.145935920568, 6029.849253768647, 6048.818535443944, 6056.0, 6065.727042283108, 6068.059450785091, 4351.151525452538, 4352.042550638855, 4352.2818734909015, 4358.476982762058, 4368.868933931987, 5840.737166827503, 5990.400959904018, 6218.191635087455, 6354.809355719336, 6365.363463653597, 4450.554944505524, 4452.866414007585, 4454.688171828006, 4458.152950939311, 4510.751908645056, 4516.570925762047, 4531.682782205214, 4549.226631472658, 4553.430821147356, 4561.543845615478, 5163.380394352626, 5165.0, 5169.4572069932865, 5170.482951704799, 5171.095058364846, 5968.1644569760265, 6098.908516372258, 6118.571699980958, 6120.449159575571, 6123.38766123393, 1583.6357637743383, 1612.346999465195, 1615.9596010099842, 1617.3368918743258, 1622.5456872075838, 1100.6697990602788, 1101.4052411697594, 1101.8071837428417, 1124.5558004588142, 1124.7750449909888, 5784.1034639630925, 5795.623284486495, 5832.650040997553, 5843.824685259449, 5847.210626565445, 6050.152978582913, 6195.19462469885, 6209.441150296405, 6273.404026617464, 6290.0, 5668.631538949955, 5677.74450149736, 5695.971520142372, 5803.7968671096305, 5832.154337621106, 3371.477420999749, 3387.0854869185673, 3395.898123056312, 3397.0997685613333, 3402.3705614461405, 6427.228732552124, 6507.414332709984, 6520.347965203442, 6561.967190164114, 6605.57063790852, 6495.870082598416, 6497.870042599122, 6498.642574658439, 6499.480041596661, 6504.1869766279215, 6589.17635295588, 6592.967035164794, 6596.505262105361, 6600.570962887397, 6608.240052394036, 6175.413335733098, 6295.622262664255, 6309.589876658002, 6310.684465776784, 6314.368563143833, 6211.751529938932, 6252.749890004349, 6253.937460625518, 6257.843553911189, 6261.24685088176, 6573.769918052845, 6576.967115164393, 6582.111414958919, 6590.308017658077, 6591.242007169237, 4452.1763473757455, 4459.085887393012, 4460.598546130864, 4462.620677242471, 4463.910721785611, 6198.256209254918, 6334.809955701337, 6339.5562310637815, 6346.524010699124, 6349.460295874902, 6125.908111378422, 6179.196704428396, 6180.825643127791, 6181.938180618136, 6186.1339412483185, 6087.330393656605, 6116.174316467398, 6156.846078848064, 6161.137440758387, 6171.1668924694595, 5892.646441213541, 6048.213732214784, 6057.333693293822, 6066.696665166813, 6113.449789518964, 6217.96891015542, 6221.626702397871, 6233.065040244, 6233.688315584293, 6234.937650623617, 6056.031035034373, 6080.939190608037, 6081.939180608138, 6095.420935011344, 6098.268207814913], "unit": "score", "name": "prototype.html", "value": 4653.268343144771}, {"lowerIsBetter": false, "replicates": [754.2909664914979, 777.5995362388368, 808.6280311056913, 838.3335248477459, 887.8623813308935, 13373.7993930091, 13566.525171618996, 13608.251546164982, 13616.795748063787, 13625.250611216366, 12488.0, 12695.238285702864, 12771.106022578424, 12966.092373533857, 13154.473821047171, 812.6668066092889, 812.7805492517047, 821.1419067074892, 821.195228675898, 824.1881746479713, 790.9367250619965, 801.3709238247976, 803.0604193094065, 803.9879401808978, 804.903411590607, 840.4495055738471, 848.6223630484437, 850.6767428377208, 851.3061854588491, 851.8083431227986, 844.1010324004915, 844.923956843884, 846.3102571404286, 846.9534175620307, 847.0, 617.2099712368176, 617.5954749638994, 617.9938200618026, 620.0265583034637, 620.4106099205773, 12383.19509231906, 12484.938780203694, 12554.74890502194, 12615.558455454015, 12630.49478020878, 9872.45701486418, 10088.89911100887, 10239.692809215736, 10433.947830260877, 10793.352398856094, 10014.298999070068, 10075.89924100757, 10130.442825644586, 10150.9492452538, 10505.2646314758, 3549.94675079874, 3604.8197590120653, 3604.873829415958, 3646.908827279339, 3662.6703596676425, 43213.35179972303, 43951.560484395064, 44265.0, 44413.55586444127, 44532.77733611344, 6753.797386078426, 9148.359614827032, 10124.139448146843, 10421.218408619385, 10533.631322903662, 18200.908995454938, 18482.445526634223, 18492.260309587466, 18512.0, 18537.0, 7405.333519983227, 7497.437692173, 7622.9237707622215, 7736.0, 7849.254320839511, 4443.333499974965, 4445.888852778707, 4448.132614140276, 4500.504944456107, 4543.863684089482, 2929.516629756109, 2939.030120060375, 2958.5710072039433, 2969.792114552004, 2971.85140742962, 529.6583703511213, 540.6593845877151, 546.2761840561272, 552.4613501835678, 563.0625009359453, 571.7541457173372, 618.981430557075, 647.1499181167396, 650.9967450162719, 651.8728847874713, 8264.421490495608, 8542.871856922151, 8571.614277357534, 8641.654333826702, 8793.164649358301, 564.4863174511175, 566.4533724955438, 572.3719330156857, 611.1596554737237, 673.3300366135726, 3820.5797362290127, 3870.9419358709642, 3922.37242041272, 4041.312976793952, 4116.629503344713, 49436.75281623569, 49609.75195124001, 49856.0, 50069.0, 50484.0, 46679.766601166775, 48350.27474587884, 48403.0, 48507.757461212466, 48627.513724863005, 39219.60780392217, 41381.37927931084, 42318.36522452166, 42655.0, 45583.77208114004, 7705.961470192613, 7710.306072453506, 7838.843223135619, 7846.293833555007, 7856.607169641381, 33666.61334186518, 34130.74973737523, 34347.141321466166, 34546.82726586351, 34560.48159277563, 36815.23885708636, 38246.61753382542, 38907.416388754755, 44297.0, 44845.775771120934, 10851.348919064882, 10897.945510272399, 11024.834627480433, 11122.61070862516, 11214.0, 11155.0, 11301.208915376174, 11314.094872410353, 12003.879961200626, 12070.84386962673, 10052.497375131361, 10126.44304563256, 10136.543855526666, 10238.232132590234, 11005.669829905115, 10584.0, 10705.9464702676, 10929.726756830825, 11383.886161138282, 11475.655730328104, 10093.293469457067, 10140.543675534765, 10279.126274266771, 10609.9469502652, 10632.41521716313, 9511.904880951102, 9693.515324233902, 9834.0, 9944.701658950244, 10618.256722029384, 8395.968822915955, 8699.521526316114, 8998.910010899806, 9043.231325337158, 9754.414735115915], "unit": "score", "name": "yui.html", "value": 6067.701966201234}], "name": "dromaeo_css", "value": 6688.120732117746}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 110.0, 112.0, 110.0, 101.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [156.0, 123.0, 149.0, 165.0, 132.0, 156.0, 151.0, 134.0, 158.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 160.0, 161.0, 159.0, 160.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 86.0, 93.0, 71.0, 71.0, 74.0, 105.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 143.0, 96.0, 97.0, 97.0, 137.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 144.0, 146.0, 145.0, 144.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 59.0, 68.0, 59.0, 60.0, 60.0, 63.0, 61.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 66.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 86.0, 85.0, 85.0, 86.0, 86.0, 85.0, 89.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [124.0, 118.0, 119.0, 116.0, 123.0, 127.0, 127.0, 122.0, 115.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [151.0, 143.0, 154.0, 158.0, 156.0, 146.0, 160.0, 153.0, 159.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.7}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 70.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1512.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.32088401576152], "unit": "score", "name": "Richards", "value": 206.05777399999997}, {"lowerIsBetter": false, "replicates": [197.12201852946976], "unit": "score", "name": "DeltaBlue", "value": 335.4166139999999}, {"lowerIsBetter": false, "replicates": [283.60748723766307], "unit": "score", "name": "Encrypt", "value": 938.5542060000004}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1937.984496124031], "unit": "score", "name": "RayTrace", "value": 381.83432400000015}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [11941.176470588236], "unit": "score", "name": "Boyer", "value": 55.812172413793114}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [655.7591623036649], "unit": "score", "name": "Splay", "value": 124.26970858283434}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19564.697588471543}]} 20:19:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19564.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1512.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6688.12"}}} 20:19:25 INFO - Return code: 0 20:19:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:19:25 INFO - # TBPL SUCCESS # 20:19:25 INFO - Running post-action listener: _resource_record_post_action 20:19:25 INFO - Running post-run listener: _resource_record_post_run 20:19:26 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549945344; Read time: 8; Write time: 423796 20:19:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 244092928; Read time: 0; Write time: 241144 20:19:26 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304599040; Read time: 8; Write time: 182208 20:19:26 INFO - Running post-run listener: _upload_blobber_files 20:19:26 INFO - Blob upload gear active. 20:19:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:19:26 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:19:26 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:19:26 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:19:27 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:27 INFO - (blobuploader) - INFO - Done attempting. 20:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:29 INFO - (blobuploader) - INFO - Done attempting. 20:19:29 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:29 INFO - Return code: 0 20:19:29 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:19:29 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4154e5fa491574c64ebb6d0c39014bb552314a40432d67c4d1e7c81c9caa688c83d9eef6d2c95c21030d61fa43af74b99c313527e572dc6921cf4b3f832e6f07", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f45950b8f4a9441dcd0d0f09678c0254549756b8c7791d7918d46ebf6193efbc54681860230c355668d113198345ce51a2b1e27256fc5147ca6e8282c0b4ad6"} 20:19:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:19:29 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:19:29 INFO - Contents: 20:19:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4154e5fa491574c64ebb6d0c39014bb552314a40432d67c4d1e7c81c9caa688c83d9eef6d2c95c21030d61fa43af74b99c313527e572dc6921cf4b3f832e6f07", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f45950b8f4a9441dcd0d0f09678c0254549756b8c7791d7918d46ebf6193efbc54681860230c355668d113198345ce51a2b1e27256fc5147ca6e8282c0b4ad6"} 20:19:29 INFO - Copying logs to upload dir... 20:19:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.640017 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-05 20:19:29.318592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 20:19:29.322576) ========= 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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 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/4154e5fa491574c64ebb6d0c39014bb552314a40432d67c4d1e7c81c9caa688c83d9eef6d2c95c21030d61fa43af74b99c313527e572dc6921cf4b3f832e6f07", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f45950b8f4a9441dcd0d0f09678c0254549756b8c7791d7918d46ebf6193efbc54681860230c355668d113198345ce51a2b1e27256fc5147ca6e8282c0b4ad6"} build_url:https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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/4154e5fa491574c64ebb6d0c39014bb552314a40432d67c4d1e7c81c9caa688c83d9eef6d2c95c21030d61fa43af74b99c313527e572dc6921cf4b3f832e6f07", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f45950b8f4a9441dcd0d0f09678c0254549756b8c7791d7918d46ebf6193efbc54681860230c355668d113198345ce51a2b1e27256fc5147ca6e8282c0b4ad6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 20:19:29.349627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:19:29.350097) ========= 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=4dd8011cc2821079d74a932a000001ae-1452052703.45256-1568311894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:19:29.433311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:19:29.433682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:19:29.434020) ========= ========= Total master_lag: 0.24 =========