builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1450788329.16 results: success (0) buildid: 20151222023004 builduid: aba6f30109bc471da4bea6a9419807e4 revision: 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.163220) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.163692) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.164015) ========= 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=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006332 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.194454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.194973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.218510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.218835) ========= 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=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004700 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.272069) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.272410) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.272801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.273144) ========= 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=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 04:45:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2015-12-22 04:45:30 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157865 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.447820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.448146) ========= 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=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.499960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.500360) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac --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 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac --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=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 04:45:30,347 truncating revision to first 12 chars 2015-12-22 04:45:30,347 Setting DEBUG logging. 2015-12-22 04:45:30,347 attempt 1/10 2015-12-22 04:45:30,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63f78eaa94e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 04:45:30,600 unpacking tar archive at: fx-team-63f78eaa94e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.064632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.064969) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.228004) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.228402) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.228835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-22 04:45:30.229158) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:31 INFO - MultiFileLogger online at 20151222 04:45:31 in /builds/slave/test-pgo 04:45:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:45:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:45:31 INFO - {'append_to_log': False, 04:45:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:45:31 INFO - 'blob_upload_branch': 'Fx-Team', 04:45:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:45:31 INFO - 'branch': 'Fx-Team', 04:45:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:31 INFO - 'config_files': ('talos/linux_config.py',), 04:45:31 INFO - 'default_actions': ('clobber', 04:45:31 INFO - 'read-buildbot-config', 04:45:31 INFO - 'download-and-extract', 04:45:31 INFO - 'populate-webroot', 04:45:31 INFO - 'create-virtualenv', 04:45:31 INFO - 'install', 04:45:31 INFO - 'run-tests'), 04:45:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:31 INFO - 'download_minidump_stackwalk': True, 04:45:31 INFO - 'download_symbols': 'ondemand', 04:45:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:31 INFO - 'installer_path': 'installer.exe', 04:45:31 INFO - 'log_level': 'info', 04:45:31 INFO - 'log_name': 'talos', 04:45:31 INFO - 'log_to_console': True, 04:45:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:31 INFO - 'opt_config_files': (), 04:45:31 INFO - 'pip_index': False, 04:45:31 INFO - 'sps_profile': False, 04:45:31 INFO - 'sps_profile_interval': 0, 04:45:31 INFO - 'suite': 'dromaeojs', 04:45:31 INFO - 'system_bits': '64', 04:45:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:31 INFO - 'title': 'talos-linux64-ix-055', 04:45:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:31 INFO - 'use_talos_json': True, 04:45:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:45:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:31 INFO - 'work_dir': 'build'} 04:45:31 INFO - ##### 04:45:31 INFO - ##### Running clobber step. 04:45:31 INFO - ##### 04:45:31 INFO - Running pre-action listener: _resource_record_pre_action 04:45:31 INFO - Running main action method: clobber 04:45:31 INFO - rmtree: /builds/slave/test-pgo/build 04:45:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:45:31 INFO - Running post-action listener: _resource_record_post_action 04:45:31 INFO - ##### 04:45:31 INFO - ##### Running read-buildbot-config step. 04:45:31 INFO - ##### 04:45:31 INFO - Running pre-action listener: _resource_record_pre_action 04:45:31 INFO - Running main action method: read_buildbot_config 04:45:31 INFO - Using buildbot properties: 04:45:31 INFO - { 04:45:31 INFO - "project": "", 04:45:31 INFO - "product": "firefox", 04:45:31 INFO - "script_repo_revision": "production", 04:45:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:45:31 INFO - "repository": "", 04:45:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:45:31 INFO - "buildid": "20151222023004", 04:45:31 INFO - "pgo_build": "True", 04:45:31 INFO - "basedir": "/builds/slave/test-pgo", 04:45:31 INFO - "buildnumber": 382, 04:45:31 INFO - "slavename": "talos-linux64-ix-055", 04:45:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:45:31 INFO - "platform": "ubuntu64_hw", 04:45:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:45:31 INFO - "branch": "fx-team", 04:45:31 INFO - "repo_path": "integration/fx-team", 04:45:31 INFO - "revision": "63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac", 04:45:31 INFO - "stage_platform": "linux64-pgo", 04:45:31 INFO - "builduid": "aba6f30109bc471da4bea6a9419807e4", 04:45:31 INFO - "slavebuilddir": "test" 04:45:31 INFO - } 04:45:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:45:31 INFO - Running post-action listener: _resource_record_post_action 04:45:31 INFO - ##### 04:45:31 INFO - ##### Running download-and-extract step. 04:45:31 INFO - ##### 04:45:31 INFO - Running pre-action listener: _resource_record_pre_action 04:45:31 INFO - Running main action method: download_and_extract 04:45:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:45: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')]} 04:45:31 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:45:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json 04:45:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json 04:45:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:45:41 INFO - Downloaded 1302 bytes. 04:45:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:45:41 INFO - Using the following test package requirements: 04:45:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:41 INFO - u'jsshell-linux-x86_64.zip'], 04:45:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:45:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:45:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:41 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')]} 04:45:41 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:50 INFO - Downloaded 23175542 bytes. 04:45:50 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 04:45:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:50 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 04:45:51 INFO - Return code: 0 04:45:51 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 04:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:51 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:54 INFO - Downloaded 23175542 bytes. 04:45:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:45:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:45:55 INFO - Return code: 0 04:45: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')]} 04:45:55 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:56 INFO - Downloaded 11132277 bytes. 04:45:56 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 04:45:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:56 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 04:45:56 INFO - Return code: 0 04:45:56 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')]} 04:45:56 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:46:00 INFO - Downloaded 54887089 bytes. 04:46:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:46:00 INFO - mkdir: /builds/slave/test-pgo/properties 04:46:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:46:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:46:00 INFO - Contents: 04:46:00 INFO - build_url:https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:46:00 INFO - Running post-action listener: _resource_record_post_action 04:46:00 INFO - Running post-action listener: set_extra_try_arguments 04:46:00 INFO - ##### 04:46:00 INFO - ##### Running populate-webroot step. 04:46:00 INFO - ##### 04:46:00 INFO - Running pre-action listener: _resource_record_pre_action 04:46:00 INFO - Running main action method: populate_webroot 04:46:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:00 INFO - '--tppagecycles', 04:46:00 INFO - '7'], 04:46:00 INFO - 'tests': ['tsvgm']}}, 04:46:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:46:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:46:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:46:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'tests': ['damp', 'tps']}, 04:46:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['damp', 'tps']}, 04:46:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:46:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:00 INFO - 'other': {'tests': ['a11yr', 04:46:00 INFO - 'ts_paint', 04:46:00 INFO - 'tpaint', 04:46:00 INFO - 'sessionrestore', 04:46:00 INFO - 'sessionrestore_no_auto_restore']}, 04:46:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['a11yr', 04:46:00 INFO - 'ts_paint', 04:46:00 INFO - 'tpaint', 04:46:00 INFO - 'sessionrestore', 04:46:00 INFO - 'sessionrestore_no_auto_restore']}, 04:46:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['a11yr', 04:46:00 INFO - 'ts_paint', 04:46:00 INFO - 'tpaint', 04:46:00 INFO - 'sessionrestore', 04:46:00 INFO - 'sessionrestore_no_auto_restore']}, 04:46:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['a11yr', 04:46:00 INFO - 'ts_paint', 04:46:00 INFO - 'tpaint', 04:46:00 INFO - 'sessionrestore', 04:46:00 INFO - 'sessionrestore_no_auto_restore']}, 04:46:00 INFO - 'other_l64': {'tests': ['a11yr', 04:46:00 INFO - 'ts_paint', 04:46:00 INFO - 'tpaint', 04:46:00 INFO - 'sessionrestore', 04:46:00 INFO - 'sessionrestore_no_auto_restore']}, 04:46:00 INFO - 'other_nol64': {'tests': ['a11yr', 04:46:00 INFO - 'ts_paint', 04:46:00 INFO - 'tpaint', 04:46:00 INFO - 'sessionrestore', 04:46:00 INFO - 'sessionrestore_no_auto_restore']}, 04:46:00 INFO - 'svgr': {'tests': ['tsvgx', 04:46:00 INFO - 'tsvgr_opacity', 04:46:00 INFO - 'tart', 04:46:00 INFO - 'tscrollx', 04:46:00 INFO - 'cart']}, 04:46:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['tsvgx', 04:46:00 INFO - 'tsvgr_opacity', 04:46:00 INFO - 'tart', 04:46:00 INFO - 'tscrollx', 04:46:00 INFO - 'cart']}, 04:46:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'tests': ['tp5o']}, 04:46:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'talos_options': ['--e10s'], 04:46:00 INFO - 'tests': ['tp5o']}, 04:46:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'talos_options': ['--xperf_path', 04:46:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:00 INFO - 'tests': ['tp5n']}, 04:46:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:00 INFO - 'talos_options': ['--e10s', 04:46:00 INFO - '--xperf_path', 04:46:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:00 INFO - 'tests': ['tp5n']}}, 04:46:00 INFO - 'talos.zip': {'path': '', 04:46:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:00 INFO - Running post-action listener: _resource_record_post_action 04:46:00 INFO - ##### 04:46:00 INFO - ##### Running create-virtualenv step. 04:46:00 INFO - ##### 04:46:00 INFO - Running pre-action listener: _resource_record_pre_action 04:46:00 INFO - Running main action method: create_virtualenv 04:46:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:46:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:46:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:46:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:00 INFO - Using real prefix '/usr' 04:46:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:46:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:03 INFO - Installing pip.................done. 04:46:03 INFO - Return code: 0 04:46:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:46:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:46:03 INFO - Using env: {'DISPLAY': ':0', 04:46:03 INFO - 'HOME': '/home/cltbld', 04:46:03 INFO - 'LANG': 'en_US.UTF-8', 04:46:03 INFO - 'LANGUAGE': 'en_US:en', 04:46:03 INFO - 'LOGNAME': 'cltbld', 04:46:03 INFO - 'MAIL': '/var/mail/cltbld', 04:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:03 INFO - 'MOZ_NO_REMOTE': '1', 04:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:03 INFO - 'NO_EM_RESTART': '1', 04:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:03 INFO - 'SHELL': '/bin/bash', 04:46:03 INFO - 'SHLVL': '1', 04:46:03 INFO - 'TERM': 'linux', 04:46:03 INFO - 'TMOUT': '86400', 04:46:03 INFO - 'USER': 'cltbld', 04:46:03 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:03 INFO - '_': '/tools/buildbot/bin/python'} 04:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:46:03 INFO - Cleaning up... 04:46:03 INFO - Return code: 0 04:46:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:46:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:46:03 INFO - Using env: {'DISPLAY': ':0', 04:46:03 INFO - 'HOME': '/home/cltbld', 04:46:03 INFO - 'LANG': 'en_US.UTF-8', 04:46:03 INFO - 'LANGUAGE': 'en_US:en', 04:46:03 INFO - 'LOGNAME': 'cltbld', 04:46:03 INFO - 'MAIL': '/var/mail/cltbld', 04:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:03 INFO - 'MOZ_NO_REMOTE': '1', 04:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:03 INFO - 'NO_EM_RESTART': '1', 04:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:03 INFO - 'SHELL': '/bin/bash', 04:46:03 INFO - 'SHLVL': '1', 04:46:03 INFO - 'TERM': 'linux', 04:46:03 INFO - 'TMOUT': '86400', 04:46:03 INFO - 'USER': 'cltbld', 04:46:03 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:03 INFO - '_': '/tools/buildbot/bin/python'} 04:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:03 INFO - Downloading/unpacking psutil>=0.7.1 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:03 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 04:46:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:46:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:46:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:06 INFO - Installing collected packages: psutil 04:46:06 INFO - Running setup.py install for psutil 04:46:06 INFO - building 'psutil._psutil_linux' extension 04:46:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:46:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:46:06 INFO - building 'psutil._psutil_posix' extension 04:46:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:46:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:46:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:06 INFO - Successfully installed psutil 04:46:06 INFO - Cleaning up... 04:46:06 INFO - Return code: 0 04:46:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:46:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:46:06 INFO - Using env: {'DISPLAY': ':0', 04:46:06 INFO - 'HOME': '/home/cltbld', 04:46:06 INFO - 'LANG': 'en_US.UTF-8', 04:46:06 INFO - 'LANGUAGE': 'en_US:en', 04:46:06 INFO - 'LOGNAME': 'cltbld', 04:46:06 INFO - 'MAIL': '/var/mail/cltbld', 04:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:06 INFO - 'MOZ_NO_REMOTE': '1', 04:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:06 INFO - 'NO_EM_RESTART': '1', 04:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:06 INFO - 'SHELL': '/bin/bash', 04:46:06 INFO - 'SHLVL': '1', 04:46:06 INFO - 'TERM': 'linux', 04:46:06 INFO - 'TMOUT': '86400', 04:46:06 INFO - 'USER': 'cltbld', 04:46:06 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:06 INFO - '_': '/tools/buildbot/bin/python'} 04:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:46:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:46:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:46:08 INFO - Installing collected packages: mozsystemmonitor 04:46:08 INFO - Running setup.py install for mozsystemmonitor 04:46:08 INFO - Successfully installed mozsystemmonitor 04:46:08 INFO - Cleaning up... 04:46:08 INFO - Return code: 0 04:46:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:46:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:46:08 INFO - Using env: {'DISPLAY': ':0', 04:46:08 INFO - 'HOME': '/home/cltbld', 04:46:08 INFO - 'LANG': 'en_US.UTF-8', 04:46:08 INFO - 'LANGUAGE': 'en_US:en', 04:46:08 INFO - 'LOGNAME': 'cltbld', 04:46:08 INFO - 'MAIL': '/var/mail/cltbld', 04:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:08 INFO - 'MOZ_NO_REMOTE': '1', 04:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:08 INFO - 'NO_EM_RESTART': '1', 04:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:08 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:08 INFO - 'SHELL': '/bin/bash', 04:46:08 INFO - 'SHLVL': '1', 04:46:08 INFO - 'TERM': 'linux', 04:46:08 INFO - 'TMOUT': '86400', 04:46:08 INFO - 'USER': 'cltbld', 04:46:08 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:08 INFO - '_': '/tools/buildbot/bin/python'} 04:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:46:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:46:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:46:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 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 04:46:11 INFO - Downloading docopt-0.6.1.tar.gz 04:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:46:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:11 INFO - Running setup.py install for blobuploader 04:46:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:46:11 INFO - Running setup.py install for requests 04:46:12 INFO - Running setup.py install for docopt 04:46:12 INFO - Successfully installed blobuploader requests docopt 04:46:12 INFO - Cleaning up... 04:46:12 INFO - Return code: 0 04:46:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:46:12 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')]} 04:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:12 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')]} 04:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:12 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 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:12 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 04:46:12 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 04:46:12 INFO - Using env: {'DISPLAY': ':0', 04:46:12 INFO - 'HOME': '/home/cltbld', 04:46:12 INFO - 'LANG': 'en_US.UTF-8', 04:46:12 INFO - 'LANGUAGE': 'en_US:en', 04:46:12 INFO - 'LOGNAME': 'cltbld', 04:46:12 INFO - 'MAIL': '/var/mail/cltbld', 04:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:12 INFO - 'MOZ_NO_REMOTE': '1', 04:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:12 INFO - 'NO_EM_RESTART': '1', 04:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:12 INFO - 'SHELL': '/bin/bash', 04:46:12 INFO - 'SHLVL': '1', 04:46:12 INFO - 'TERM': 'linux', 04:46:12 INFO - 'TMOUT': '86400', 04:46:12 INFO - 'USER': 'cltbld', 04:46:12 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:12 INFO - '_': '/tools/buildbot/bin/python'} 04:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:46:12 INFO - Running setup.py (path:/tmp/pip-nndPzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:46:12 INFO - Running setup.py (path:/tmp/pip-BKedGy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:46:12 INFO - Running setup.py (path:/tmp/pip-KsY0ym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:46:12 INFO - Running setup.py (path:/tmp/pip-6HMf1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:46:12 INFO - Running setup.py (path:/tmp/pip-sp1tuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:46:12 INFO - Running setup.py (path:/tmp/pip-yL6HVG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:46:12 INFO - Running setup.py (path:/tmp/pip-m0DE74-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:46:12 INFO - Running setup.py (path:/tmp/pip-3FyohK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:46:13 INFO - Running setup.py (path:/tmp/pip-MSEDlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:46:13 INFO - Running setup.py (path:/tmp/pip-nuTIYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:46:13 INFO - Running setup.py (path:/tmp/pip-SIdkjd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:46:13 INFO - Running setup.py (path:/tmp/pip-x3_rv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:46:13 INFO - Running setup.py (path:/tmp/pip-VYI8KS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:46:13 INFO - Running setup.py (path:/tmp/pip-0q3bUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:46:13 INFO - Running setup.py (path:/tmp/pip-_nsJls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:46:13 INFO - Running setup.py (path:/tmp/pip-oWLQrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:46:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:46:13 INFO - Running setup.py (path:/tmp/pip-Vee0vU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:46:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:13 INFO - Running setup.py install for manifestparser 04:46:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:46:13 INFO - Running setup.py install for mozcrash 04:46:13 INFO - Running setup.py install for mozdebug 04:46:13 INFO - Running setup.py install for mozdevice 04:46:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Running setup.py install for mozfile 04:46:14 INFO - Running setup.py install for mozhttpd 04:46:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Running setup.py install for mozinfo 04:46:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Running setup.py install for mozInstall 04:46:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Running setup.py install for mozleak 04:46:14 INFO - Running setup.py install for mozlog 04:46:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Running setup.py install for moznetwork 04:46:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:46:14 INFO - Running setup.py install for mozprocess 04:46:14 INFO - Running setup.py install for mozprofile 04:46:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:46:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:46:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:46:15 INFO - Running setup.py install for mozrunner 04:46:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:46:15 INFO - Running setup.py install for mozscreenshot 04:46:15 INFO - Running setup.py install for moztest 04:46:15 INFO - Running setup.py install for mozversion 04:46:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:46:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:15 INFO - Cleaning up... 04:46:15 INFO - Return code: 0 04:46:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:46:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:46:15 INFO - Using env: {'DISPLAY': ':0', 04:46:15 INFO - 'HOME': '/home/cltbld', 04:46:15 INFO - 'LANG': 'en_US.UTF-8', 04:46:15 INFO - 'LANGUAGE': 'en_US:en', 04:46:15 INFO - 'LOGNAME': 'cltbld', 04:46:15 INFO - 'MAIL': '/var/mail/cltbld', 04:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:15 INFO - 'MOZ_NO_REMOTE': '1', 04:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:15 INFO - 'NO_EM_RESTART': '1', 04:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:15 INFO - 'SHELL': '/bin/bash', 04:46:15 INFO - 'SHLVL': '1', 04:46:15 INFO - 'TERM': 'linux', 04:46:15 INFO - 'TMOUT': '86400', 04:46:15 INFO - 'USER': 'cltbld', 04:46:15 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:15 INFO - '_': '/tools/buildbot/bin/python'} 04:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:46:15 INFO - Running setup.py (path:/tmp/pip-KHS6Sg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:46:15 INFO - Running setup.py (path:/tmp/pip-8tTpdl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:46:15 INFO - Running setup.py (path:/tmp/pip-_4hbTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:46:15 INFO - Running setup.py (path:/tmp/pip-Xch0zB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:46:15 INFO - Running setup.py (path:/tmp/pip-dk5xC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:46:16 INFO - Running setup.py (path:/tmp/pip-t0Nscb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:46:16 INFO - Running setup.py (path:/tmp/pip-MU8PjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:46:16 INFO - Running setup.py (path:/tmp/pip-NM1hbn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:46:16 INFO - Running setup.py (path:/tmp/pip-Cda206-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:46:16 INFO - Running setup.py (path:/tmp/pip-VOWkTO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:46:16 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)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:46:16 INFO - Running setup.py (path:/tmp/pip-OEw2Md-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:46:16 INFO - Running setup.py (path:/tmp/pip-tK2GkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:46:16 INFO - Running setup.py (path:/tmp/pip-dvbSWl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:46:16 INFO - Running setup.py (path:/tmp/pip-UfgmXm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:46:16 INFO - Running setup.py (path:/tmp/pip-jpNvYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:46:16 INFO - Running setup.py (path:/tmp/pip-j_WJ5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:46:16 INFO - Running setup.py (path:/tmp/pip-9hRJUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:18 INFO - Downloading blessings-1.5.1.tar.gz 04:46:18 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:46:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:18 INFO - Installing collected packages: blessings 04:46:18 INFO - Running setup.py install for blessings 04:46:18 INFO - Successfully installed blessings 04:46:18 INFO - Cleaning up... 04:46:18 INFO - Return code: 0 04:46:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:46:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:46:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:46:19 INFO - Reading from file tmpfile_stdout 04:46:19 INFO - Current package versions: 04:46:19 INFO - argparse == 1.2.1 04:46:19 INFO - blessings == 1.5.1 04:46:19 INFO - blobuploader == 1.2.4 04:46:19 INFO - docopt == 0.6.1 04:46:19 INFO - manifestparser == 1.1 04:46:19 INFO - mozInstall == 1.12 04:46:19 INFO - mozcrash == 0.16 04:46:19 INFO - mozdebug == 0.1 04:46:19 INFO - mozdevice == 0.47 04:46:19 INFO - mozfile == 1.2 04:46:19 INFO - mozhttpd == 0.7 04:46:19 INFO - mozinfo == 0.9 04:46:19 INFO - mozleak == 0.1 04:46:19 INFO - mozlog == 3.1 04:46:19 INFO - moznetwork == 0.27 04:46:19 INFO - mozprocess == 0.22 04:46:19 INFO - mozprofile == 0.28 04:46:19 INFO - mozrunner == 6.11 04:46:19 INFO - mozscreenshot == 0.1 04:46:19 INFO - mozsystemmonitor == 0.0 04:46:19 INFO - moztest == 0.7 04:46:19 INFO - mozversion == 1.4 04:46:19 INFO - psutil == 3.1.1 04:46:19 INFO - requests == 1.2.3 04:46:19 INFO - wsgiref == 0.1.2 04:46:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:19 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 04:46:19 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 04:46:19 INFO - Using env: {'DISPLAY': ':0', 04:46:19 INFO - 'HOME': '/home/cltbld', 04:46:19 INFO - 'LANG': 'en_US.UTF-8', 04:46:19 INFO - 'LANGUAGE': 'en_US:en', 04:46:19 INFO - 'LOGNAME': 'cltbld', 04:46:19 INFO - 'MAIL': '/var/mail/cltbld', 04:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:19 INFO - 'MOZ_NO_REMOTE': '1', 04:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:19 INFO - 'NO_EM_RESTART': '1', 04:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:19 INFO - 'SHELL': '/bin/bash', 04:46:19 INFO - 'SHLVL': '1', 04:46:19 INFO - 'TERM': 'linux', 04:46:19 INFO - 'TMOUT': '86400', 04:46:19 INFO - 'USER': 'cltbld', 04:46:19 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:19 INFO - '_': '/tools/buildbot/bin/python'} 04:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 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)) 04:46:19 INFO - Cleaning up... 04:46:19 INFO - Return code: 0 04:46:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:46:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:46:19 INFO - Using env: {'DISPLAY': ':0', 04:46:19 INFO - 'HOME': '/home/cltbld', 04:46:19 INFO - 'LANG': 'en_US.UTF-8', 04:46:19 INFO - 'LANGUAGE': 'en_US:en', 04:46:19 INFO - 'LOGNAME': 'cltbld', 04:46:19 INFO - 'MAIL': '/var/mail/cltbld', 04:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:19 INFO - 'MOZ_NO_REMOTE': '1', 04:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:19 INFO - 'NO_EM_RESTART': '1', 04:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:19 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:19 INFO - 'SHELL': '/bin/bash', 04:46:19 INFO - 'SHLVL': '1', 04:46:19 INFO - 'TERM': 'linux', 04:46:19 INFO - 'TMOUT': '86400', 04:46:19 INFO - 'USER': 'cltbld', 04:46:19 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:19 INFO - '_': '/tools/buildbot/bin/python'} 04:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:19 INFO - Downloading/unpacking jsonschema 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:21 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 04:46:21 INFO - Downloading/unpacking functools32 (from jsonschema) 04:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:46:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:21 INFO - warning: no files found matching '*.txt' 04:46:21 INFO - no previously-included directories found matching 'build' 04:46:21 INFO - no previously-included directories found matching 'dist' 04:46:21 INFO - no previously-included directories found matching '.git*' 04:46:21 INFO - Installing collected packages: jsonschema, functools32 04:46:21 INFO - Running setup.py install for functools32 04:46:21 INFO - warning: no files found matching '*.txt' 04:46:21 INFO - no previously-included directories found matching 'build' 04:46:21 INFO - no previously-included directories found matching 'dist' 04:46:21 INFO - no previously-included directories found matching '.git*' 04:46:21 INFO - Successfully installed jsonschema functools32 04:46:21 INFO - Cleaning up... 04:46:21 INFO - Return code: 0 04:46:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6750481f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, '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': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', '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 04:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:46:21 INFO - Using env: {'DISPLAY': ':0', 04:46:21 INFO - 'HOME': '/home/cltbld', 04:46:21 INFO - 'LANG': 'en_US.UTF-8', 04:46:21 INFO - 'LANGUAGE': 'en_US:en', 04:46:21 INFO - 'LOGNAME': 'cltbld', 04:46:21 INFO - 'MAIL': '/var/mail/cltbld', 04:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:21 INFO - 'MOZ_NO_REMOTE': '1', 04:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:21 INFO - 'NO_EM_RESTART': '1', 04:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:21 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:21 INFO - 'SHELL': '/bin/bash', 04:46:21 INFO - 'SHLVL': '1', 04:46:21 INFO - 'TERM': 'linux', 04:46:21 INFO - 'TMOUT': '86400', 04:46:21 INFO - 'USER': 'cltbld', 04:46:21 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:21 INFO - '_': '/tools/buildbot/bin/python'} 04:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:21 INFO - Downloading/unpacking flake8 04:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:46:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:46:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:46:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:46:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:46:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:46:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:46:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:24 INFO - no previously-included directories found matching 'docs/_build' 04:46:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:46:24 INFO - Running setup.py install for pep8 04:46:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:24 INFO - no previously-included directories found matching 'docs/_build' 04:46:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:46:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:46:24 INFO - Cleaning up... 04:46:24 INFO - Return code: 0 04:46:24 INFO - Running post-action listener: _resource_record_post_action 04:46:24 INFO - Running post-action listener: _start_resource_monitoring 04:46:24 INFO - Starting resource monitoring. 04:46:24 INFO - ##### 04:46:24 INFO - ##### Running install step. 04:46:24 INFO - ##### 04:46:24 INFO - Running pre-action listener: _resource_record_pre_action 04:46:24 INFO - Running main action method: install 04:46:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:46:24 INFO - Reading from file tmpfile_stdout 04:46:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:46:24 INFO - Reading from file tmpfile_stdout 04:46:24 INFO - Output received: 04:46:24 INFO - Usage: mozinstall [options] installer 04:46:24 INFO - Options: 04:46:24 INFO - -h, --help show this help message and exit 04:46:24 INFO - -d DEST, --destination=DEST 04:46:24 INFO - Directory to install application into. [default: 04:46:24 INFO - "/builds/slave/test-pgo"] 04:46:24 INFO - --app=APP Application being installed. [default: firefox] 04:46:24 INFO - mkdir: /builds/slave/test-pgo/build/application 04:46:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:46:40 INFO - Reading from file tmpfile_stdout 04:46:40 INFO - Output received: 04:46:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:46:40 INFO - Running post-action listener: _resource_record_post_action 04:46:40 INFO - ##### 04:46:40 INFO - ##### Running run-tests step. 04:46:40 INFO - ##### 04:46:40 INFO - Running pre-action listener: _resource_record_pre_action 04:46:40 INFO - Running main action method: run_tests 04:46:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:46:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:46:40 INFO - Python 2.7.3 04:46:40 INFO - Return code: 0 04:46:40 INFO - grabbing minidump binary from tooltool 04:46: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')]} 04:46:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e840>, '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 0x157b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:46:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:46:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:46:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:40 INFO - Return code: 0 04:46:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:46:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:46:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:46:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:46:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:46:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:46:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:46:41 INFO - Return code: 0 04:46:41 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/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:46:41 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/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 04:46:41 INFO - Using env: {'DISPLAY': ':0', 04:46:41 INFO - 'HOME': '/home/cltbld', 04:46:41 INFO - 'LANG': 'en_US.UTF-8', 04:46:41 INFO - 'LANGUAGE': 'en_US:en', 04:46:41 INFO - 'LOGNAME': 'cltbld', 04:46:41 INFO - 'MAIL': '/var/mail/cltbld', 04:46:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:46:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:41 INFO - 'MOZ_NO_REMOTE': '1', 04:46:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:41 INFO - 'NO_EM_RESTART': '1', 04:46:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:46:41 INFO - 'SHELL': '/bin/bash', 04:46:41 INFO - 'SHLVL': '1', 04:46:41 INFO - 'TERM': 'linux', 04:46:41 INFO - 'TMOUT': '86400', 04:46:41 INFO - 'USER': 'cltbld', 04:46:41 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999', 04:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:41 INFO - '_': '/tools/buildbot/bin/python'} 04:46:41 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/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:46:41 INFO - mozversion application_buildid: 20151222023004 04:46:41 INFO - mozversion application_changeset: 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac 04:46:41 INFO - mozversion application_display_name: Nightly 04:46:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:41 INFO - mozversion application_name: Firefox 04:46:41 INFO - mozversion application_remotingname: firefox 04:46:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:46:41 INFO - mozversion application_vendor: Mozilla 04:46:41 INFO - mozversion application_version: 46.0a1 04:46:41 INFO - mozversion platform_buildid: 20151222023004 04:46:41 INFO - mozversion platform_changeset: 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac 04:46:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:46:41 INFO - mozversion platform_version: 46.0a1 04:46:41 INFO - using testdate: 1450788401 04:46:41 INFO - actual date: 1450788401 04:46:41 INFO - starting webserver on 'localhost:35482' 04:46:41 INFO - SUITE-START | Running 3 tests 04:46:41 INFO - TEST-START | dromaeo_css 04:46:41 INFO - operating with platform_type : linux_ 04:46:41 INFO - Initialising browser for dromaeo_css test... 04:46:41 INFO - TEST-INFO | started process 8783 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1p5itW/profile http://localhost:35482/getInfo.html) 04:46:45 INFO - PROCESS | 8783 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:46:46 INFO - PROCESS | 8783 | __metrics Screen width/height:1600/1200 04:46:46 INFO - PROCESS | 8783 | colorDepth:24 04:46:46 INFO - PROCESS | 8783 | Browser inner width/height: 1024/697 04:46:46 INFO - PROCESS | 8783 | __metrics 04:46:46 INFO - PROCESS | 8783 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:46:46 INFO - PROCESS | 8783 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:47 INFO - TEST-INFO | 8783: exit 0 04:46:47 INFO - Browser initialized. 04:46:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:47 INFO - TEST-INFO | started process 8876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1p5itW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:59 INFO - PROCESS | 8876 | RSS: Main: 150470656 04:46:59 INFO - PROCESS | 8876 | 04:47:50 INFO - PROCESS | 8876 | 1450788470852 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] 04:49:59 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:35482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35482/tests/dromaeo/cssquery-ext.html) 04:50:00 INFO - PROCESS | 8876 | RSS: Main: 296177664 04:50:00 INFO - PROCESS | 8876 | 04:53:03 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:35482/tests/dromaeo/cssquery-ext.html (next: http://localhost:35482/tests/dromaeo/cssquery-jquery.html) 04:53:03 INFO - PROCESS | 8876 | RSS: Main: 230232064 04:53:03 INFO - PROCESS | 8876 | 04:56:05 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:35482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35482/tests/dromaeo/cssquery-mootools.html) 04:56:06 INFO - PROCESS | 8876 | RSS: Main: 229687296 04:56:06 INFO - PROCESS | 8876 | 04:59:07 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:35482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35482/tests/dromaeo/cssquery-prototype.html) 04:59:08 INFO - PROCESS | 8876 | RSS: Main: 212164608 04:59:08 INFO - PROCESS | 8876 | 05:02:10 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:35482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35482/tests/dromaeo/cssquery-yui.html) 05:02:11 INFO - PROCESS | 8876 | RSS: Main: 215703552 05:02:11 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:35482/tests/dromaeo/cssquery-yui.html (next: http://localhost:35482/tests/dromaeo/cssquery-dojo.html) 05:05:14 INFO - PROCESS | 8876 | RSS: Main: 274407424 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | __start_tp_report 05:05:14 INFO - PROCESS | 8876 | _x_x_mozilla_page_load 05:05:14 INFO - PROCESS | 8876 | _x_x_mozilla_page_load_details 05:05:14 INFO - PROCESS | 8876 | |i|pagename|runs| 05:05:14 INFO - PROCESS | 8876 | |0;dojo.html;3097.30310680097;3144.9842750786243;3173.9841300793505;3191.601049868765;3211.2132527530744;5164.328637277149;5298.284731561238;5309.761060752266;5327.653702509334;5336.866578335539;5275.868103297419;5311.601629877755;5323.1749078892735;5332.413434522209;5432.538234250083;4828.7585620719;4837.153498137829;4880.999395123991;4964.379452568429;4990.600751939836;4887.6089912807065;4906.362172917516;4951.133551628469;4979.50204979501;5041.52105549974;4719.480857105716;4797.11253418117;4860.125177468054;4955.306257124005;4976.527229913152;4955;4983.451820299764;4986.626003049786;4991.575716064139;5009.824656137018;4862.44081930579;4945.67853089548;4952.702837829742;4956.801727930879;4980.7509624518625;5170.250313704491;5173;5275.129603615399;5300.496452836975;5369.812056578001;5811.6803575803315;5866.853328666774;5881.735321910524;5884.264466941632;5891.882162356772;5886.735096920606;5894.997850365448;5903.940960590382;5904.291485021782;5910.261217347832;5259.894802103937;5351.625386222966;5359.5444387227135;5376.91934620981;5439.428859969726;5913.586048976616;5931.584789064724;5937.554683398763;5937.82186534396;5979.880402391927;5698.031334673115;5698.031334673115;5700.287464066992;5711.400302968212;5743.167240750068;5575.581831362664;5745.425457454221;5745.712714364265;5774;5843.357230704619;5788.82633520995;5792.652440853562;5794.362620111784;5796.797112101056;5837.620554663933;5791.3339965903615;5796.62321949072;5799.072148456226;5801.622894511927;5809.970950145223;4396.560343965642;4483.21543729846;4494.12364588902;4495.056038231943;4496.460424749051;3946.703997200164;4016.256992456405;4044.0698639313123;4050.675945924319;4052.858149964737;5385.542228910508;5458.426865179178;5459.69971651555;5489.149181876815;5505.256790333334;5784.88430231393;5820.097884827858;5823.5341172706085;5842.5618078644275;5846.619969701956;5306.177542480922;5388.741538339721;5403.7838486460105;5462.863428414322;5466.644668096561;4930.482299358588;5051.646384753032;5109.156989096758;5126;5160.09698302803;5922.111683247547;5940.70296485174;5942.762289508371;5943.70281485924;5947.256592925884;5546.778128874961;5721.256236689203;5832.562557808096;5859.970700146472;5862.618929769551;5841.153032810304;5881;5899.67551784656;5921.230240068763;5943.791967281124;5625.324961004706;5645.802396916252;5652.123920792284;5653.293338332708;5753.280839895013;5734.827955161351;5737.282839645044;5738.626989245686;5742.712864356682;5762.222100016612;5452.182172674131;5553.0559804832465;5554.861128471659;5636.323641163087;5690.886182276414;5631.802886898939;5716.771329146954;5718.1708652246025;5722.742476588647;5733;5616.775328986795;5626.5780066496;5631.63394379364;5637.069883469346;5642.181883626769;5624.381318054929;5628.943710562842;5663.405342438985;5714.171445140514;5725.799597014085;5507.394186639546;5607.859803504945;5630.8029218977135;5634.577406694432;5648.4633959773755 05:05:14 INFO - PROCESS | 8876 | |1;ext.html;562.9240052592901;613.880293342798;615.5844804756788;615.6121643364679;619.3837132053608;29715.108546743606;30362.544561831564;38273.234535309275;38291.234175316546;38306.8084659577;42618.78690606551;42953.35569966453;42978.78510607443;43054;43066;8747.562621868912;8914.643414263423;8918.910810891904;8919.28645708345;8924.196822285992;7816.17930117338;7996.960015199916;10335.638252661158;10540.947295263513;10569.154467642571;10376.792464150712;10482.371057736522;10483.68548943533;10487.265891387606;10505.579776808918;7849.215078492105;8021.839563208761;10310.690679279596;10412.219083568763;10413.271071025032;10432.478376081166;10682.03861652455;10689.251752377337;10694.732631684192;10702.678919632424;39241.03794810248;39473.802630986946;39656.60343396558;39714.20571588581;39749.80125099385;3310.8841190558214;3362.5796775403073;3696.2792255510185;3899.5320561532512;4132.648724858391;29651.851740741375;29818;30179.245518862204;30228.09315720532;31128.377432451223;3391.9491207631904;3469.61834198238;3518.9120271993147;3529.876454324112;3631.346357655621;281277;283528;284885;285200;285421.5728921363;53766.46233537615;55325;55501.16748248779;56967.71516142393;57268;63874.68062659657;64085.359146407936;64508.677456612415;64560.67719661372;64726.676366618805;14824.703505929821;15097.245137743288;15104.622384440478;15120;15131;10882;10932.726681833017;11016.17378696585;11016.669499915015;11034.006939375495;18529.351472698392;18575.16411761474;18713.53216169607;18741.531461713566;18837;7217.7473788417155;7497.10034795828;7538.434617403716;7597;7611.238876112345;938.3525367496405;975.7463059604554;1006.6325791086201;1022.1669339488293;1059.6026490066224;28009.859950700116;28206.294842629097;28415;28501.15525080139;28692.569611455845;1039.3504059962524;1046.3564907581783;1046.5604446132643;1061.1881910338598;1068.150820098024;14809.62975925589;14868.479603214051;15078.849211507964;15089.622759431102;15093.622659433382;323961;326795;328577;328625;328831;51492.74253628783;51816;51829.48170518322;51889;51943.48056519462;1308.9214647121203;1316.8814806667447;1327.8672132786644;1335.5525898823807;1337.612092493166;27083.1875043749;28159.296017599725;28362.149135525968;29296.853515732284;30804.75557745242;46861.76569117133;47291.76354118345;47346.76326618345;47388.7630561845;47438;252161;254181;254758;255058;255578;28023.579646304916;28354.85822570874;30874.073777786703;31102;31500.212494687818;40960.1807963845;41067.794661026506;41542.792286039585;41966;42157.78921105375;33332.333353333284;34169;34397;34626.48060279048;34929.825350873085;29459.55810662799;34833.65166348304;35329.29341413209;35449.64550354567;35765.82117089398;30125.548116778704;33690.157746056546;33692.49461258132;33705.83147084249;33765.83117084399;28415.43169136647;31930.36139277155;32269.692990558622;33845.492317615746;35034;24011.27966161018;24181.274561763174;24384.26847194587;24536;24592.631110533 05:05:14 INFO - PROCESS | 8876 | |2;jquery.html;338.87461639193504;346.6516151267977;346.7763292676224;347.5933158204901;348.4285771335013;13657.180569165857;14048.227347495884;16410.917945410285;16574.254158562864;17372.391966281182;15710.293036813342;15759.60600984976;16413.17934103296;16415;16417.589560261;5023.748812559366;5376.838694839161;5385.299911011563;5386.461353864622;5386.730663466811;3933.6656384207236;4026.2752704513177;4029.5567487576345;5273.86815329616;5693.886122277573;5739.799107031255;5763.049096899007;5777.335606405275;5782.826515204551;5791.855203619901;5632.549396048326;5787.392323806003;5789.305283365981;5796.2464879565805;5797.681127537984;5085.1355269604255;5093.159628661267;5095.286659867622;5102.846914592568;5104.69371837691;20304.69542956857;20855.791442085538;21177.576448470943;21254.36236912895;21291;2162.859414138076;2168.98915505423;2185.5519618478174;2249;2636.1003144109204;8494.108118647515;8534.658613655509;8663;12558.74882502345;13178.472861085545;1589.9205039748083;1591.1328326062207;1597.177453611391;1628.0077068988603;1657.3709915496859;60707;63448.365516344704;64279.678601607164;64715;65425;9302.53487325631;9779.755506112404;9884.654037108667;10365.533550990072;10506.632267870587;12946.67633309156;13019.739605208033;13046.869531304756;13047.151935124186;13047.217166970013;7430.814229644302;7504.061992250969;7532.359749421361;7575.734849280248;7622.771316860503;7204.387627051759;7223.097112860893;7227.927720722725;7261.947017682406;7268.018817459681;3920.0591857953887;4309.267424537836;4362.083962367875;4472.709273897186;4505.053938672915;1671.4400675773752;1715.1424287856073;1726.3181043487753;1727.7494763259258;1797.694391953371;919.1268295119529;928.8374534456443;959.9184069354183;968.9951550242204;983.9901600984042;16432.671346573003;16798;17074.2316595751;17180.484585462455;17261.3958511454;854.5641722721457;881.6209030116983;924.8104138651561;940.7168980258847;1004.1615251265275;6714.462842972551;9129.895835415991;9189.356745027917;9197.908020919838;9466.29002824791;556144;556179;562402;601870;604679;53175.468245317825;76316.61841690756;76842;85295.57352213199;86892.5655371719;1117.7708569743345;1137.789508940832;1142.4630423700846;1151.7235863392725;1153.1754795321217;14396.352164152848;15645.139517326656;15735.44925927587;15909.522714318126;16068.35726570924;35444;35800.8209958959;36000.81999589985;36763.26473470462;37237.441438378984;44797.776011119735;44865.327020094075;45924;47511.76244118757;49384.50615493799;8899.199072083544;9137.725868223964;9210.631574736935;9598.136167744937;9627.133557979816;11263.831042534532;11490.195686301879;11531.423428828693;11579.24734892263;17190.31238750436;13987.370568324654;14600.342984565932;14723.926380368459;14780.408783648534;15097.47158849435;14631.268436577915;14694;14991.850081499046;15141;15157.848421515644;14064.296785160497;14143.929280353945;14524.927375363055;14696.779548306999;15742.527724168292;8377.623006964823;8594.78513037179;8648.827023459622;8719.52042637661;8743.644735066075;9061.093890610886;9107.908920910706;11518.654440366803;13844.37700303509;14295.428182872569 05:05:14 INFO - PROCESS | 8876 | |3;mootools.html;1361.836579610447;1467.3983666696654;1509.7282489151955;1621.9594510137244;1745.4152858792297;6880.483963702717;7427.962860185698;7596.544207347549;7605.999999999993;7611.467197296191;7616.7334143305;7739.845203095934;7754.2245775422425;7775;7783.299503044725;1995.0922330339733;2021.6866385710239;2030.0458784371322;2154.7845215478483;2193.111789725164;2038.3986723916405;2243.932682019542;2258.424101854025;2274.7042884425;2274.863508189514;2194.47332640166;2197.187040794908;2203.5372571759867;2207.9116835326568;2300.5628930503235;2241.607718649238;2269.5914735347715;2270.8751018694047;2271.3299576624936;2272.397814579138;2253.1438053539714;2307.86152830829;2309.6304591265484;2310.9306720798404;2312.9653055204185;7459.216782237895;7509.436792240549;7530.924690753077;7533.849323013564;7554.244575542457;4559.088182363507;4641.373414589021;4651.953480465186;4657.906841863178;4660.557247061523;2997.14581344318;3096.3342881280632;3122.172624254574;3125.0937228203793;3144.591203143577;891.4784850862253;906.5240748606968;914.862770584411;953.5708930981017;972.9805403891883;10505.579776808918;10621.097206737437;10676.946615266952;10770.78458430827;10788.136949044057;4102.794860257035;4116.526599441043;4155.106652069759;4187.97906010468;4204.726692764961;9054.683086091954;9076.455412675261;9125.634974600942;9129.452232865917;9166.770830729285;4497.055618320124;4548.499665036843;4562.5665561771575;4572.6799124061;4573.885652858705;4072.714909956275;4113.609207125318;4123.8969025773995;4129.339305711132;4148.730332528376;3268.150280926976;3541.964580354215;3545.3263879862743;3545.6808887200277;3594.0475773919934;1065.5631191211567;1088.1240601315858;1112.477135746198;1118.6476259978244;1120.618989543559;1011.2668315471225;1011.3476807459294;1079.1474734959295;1136.3693150301497;1293.049608537724;7149.106361704787;7208.387287080552;7281.817954551073;7293.161286452126;7300.233475485104;1122.2424863217295;1123.5225029362653;1130.8303754436736;1132.297975255347;1148.7472755993667;5654.547636189095;5704.80033198836;5714.257146570919;5714.9714251429305;5720.485156335866;9115.225205857443;9136.177744003071;9514.619415223451;9517.762055948519;9528.285378596633;9316.254699624149;9357.766055848659;9429.717108486757;9431.245500359955;9440.858387124199;7131.465140114512;7265;7299.817504562322;7307.2327405621645;7310.634468276565;6996.545224560387;7028.859422811617;7052.0479735235085;7056.894146587908;7090.361867431956;7914.089879663912;8103.675852966051;8380.455270407405;8385.538795366314;8409;8645.610947507503;8719.91280087191;8726.127387261224;8737.475751454933;8739.956300218459;6602.438792702674;6726.192856857013;6752.088468056946;6766.661666916733;6768.052472653734;6371.076193951758;6722.462203023649;7466.36535894455;7547.5848828314965;7588.27911348421;6793.116894803644;6817.5568588041615;6873.690683919136;6992.895106573507;7021.4031807294905;6613.2394774601535;6867.519273650796;6876.312368763083;6960.825979350354;6985.441164706913;6926.099607051051;6932.653367331714;6963.547369420971;6964.408025317702;6967.860642787217;6330.082138090043;6354.332795056453;6366;6382.36176382358;6402.35976402356;6322.114903913363;6383.042543618494;6399.55203135776;6407.743690252338;6436.259830119596 05:05:14 INFO - PROCESS | 8876 | |4;prototype.html;322.27166603476144;325.0314064089015;327.4008564327281;328.6729703944575;329.2805220593003;5905.055191169419;5906.793262235823;5907.320658124317;5929;5934.287885453741;5621.634593751413;5688.175214593882;5771.961047011547;5826.4173582641715;5858.648481091138;4468.575485328888;4479.820807167709;4486.035502366991;4494.258447356182;4498.257787465081;4274.97862510687;4486.775661216942;4494.5730155635165;4502.752348620825;4507.909841803162;4344.45694288214;4377.540358262384;4463.955360446403;4473.485549161839;4483.977580112111;4449.2213862574245;4452.042810795679;4468.463784345867;4468.865934021952;4471.865844024668;3914.941275880864;3917.216556688674;3922.666573341269;3924.31324518211;3924.3721004639406;5499.615026948115;5585.106382978704;5587.972060139673;5589.217509548666;5591.133374326986;5213.635045546814;5218.817341393071;5223.555997740196;5227.843164705065;5231.476852314738;6198.3801619838105;6211.596246243979;6216.906746398808;6221.440070393686;6225.3774622537385;4357.84747533838;4362.847300344472;4370.715903466296;4375.2124617568825;4381.298992161271;6320.525960552931;6417.614943103429;6452.161219041542;6457.515686323498;6462.870742585122;4445.044315472124;4450.577195166454;4452.131834292347;4453.131639330364;4453.866384008485;4505.211587972091;4507.166174257707;4510.391097201901;4511.796969136397;4512.2554778461845;5178.663386879841;5199.804045069655;5202;5210.895782084337;5212.50481204285;6121.663308517986;6220.564560480723;6240.687965601702;6247.5939063960695;6274;1548.899321544096;1549.7907782449452;1553.0914415067311;1553.1923399832024;1556.8209655889718;1045.482486169351;1049.4490392543976;1066.9543847029954;1067.802456545526;1072.769354588767;6051.334353221142;6056.515478761777;6059.1820104286235;6064.151018857276;6066.969665151646;6469.935300647027;6474.093626892239;6479.092926990225;6479.449246814073;6480.51396145291;5901.734421951022;5914.142449344907;6028.065649824284;6098.26820781509;6117.388261173847;3483.808390538494;3504.351694936445;3518.4370500720274;3519.331327047853;3522.7534072615185;6652.73389064432;6657.833554161185;6664.400203981665;6664.500162487736;6665.300143484961;6549;6679.031540426611;6685.832854178684;6690;6692.330766923366;6657.667116644148;6659.067730517731;6660.400563949268;6664.400203981665;6667.19993600771;6510.316416776171;6511.544191906521;6516.380943810331;6517.4134327910715;6526.086347911201;6309.842253943688;6442.935570644234;6449.806505804833;6452.935470645233;6455.580387274812;6613.173353330833;6626.83432914181;6638.601683898982;6646.368594983469;6648.767293144717;4542.1824071667415;4545.954540454553;4546.568076032771;4550.13547425988;4550.590446859666;6362.809115726535;6507.609543427409;6522.184726909137;6523;6524.641144737085;6298.08677741734;6340.968295158495;6341.365863413806;6343.111964324906;6353.682315884095;6324.083007963912;6324.747010119544;6327.209098862642;6328.240611126695;6333.429991300805;6037.667928263988;6216.813495595139;6245.594036387621;6255;6262.53031022666;6320.273168585672;6376.649284289409;6398;6399.2640846303275;6402.455791257609;6233.75064997395;6238.407351301619;6240.438360547572;6241.594296370721;6249.843753906007 05:05:14 INFO - PROCESS | 8876 | |5;yui.html;744.7393412305692;760.9695612175511;798.9241022102901;831.6091437024596;863.3266052479069;13269.469221231151;13619.523316683919;13630.114042587225;16033.679326413465;16250.83749162508;14904.254787260648;14966.700665986673;14998.100113993169;15005.84994150058;15013.624659383493;667.8797816393047;803.7789607857842;819.971301004465;820.7660816667251;820.8604537228686;675.8614484030786;809.5142914251431;819.5001049359886;824.381713714714;825.9297959673435;847.6058632735777;861.8104017116225;862.0431321233426;862.1292494580456;862.4264863865521;692.4737199728193;702.0311969482082;843.5360551696604;856.1181982557944;859.2996707683218;634.4892361648871;636.3954243468677;637.6843462486099;638.7285403703454;639.0797251957167;13320.467181312735;13457.730845383136;13564.389602467912;13575.321233938264;13634.318284085755;10934.507947142398;11252.718682033015;11491.253068550517;11604.825927611093;11793.115516336224;9407.952960235223;9986.550605222783;10078.244131690153;10248;10322.122619577345;3344.5484859543894;3435.4331535296647;3439.008609963664;3449.189440481485;3539.50446937429;48606;49148.75425622885;49210;49807.750961244965;51167.48832511665;9125.543364733288;9154.67958621445;9179.495127767903;9217.400868943498;9220.723378298662;15755.606109847346;15799.763003554956;15806.525804225892;15850.920745396199;15863.365465381487;6865.450763938873;6978.232394436608;7301.379382752525;7395.112586489656;7412.221716719775;3914.2954268231993;4025;4137.8758637240935;4164.167166566699;4199.0552125772065;2944.131481213047;2975.1074677596635;2988.581598576201;2992.356643321696;2997.860812891131;543.9510444060054;562.3083607163212;566.8554518597731;568.2186992884783;574.1072632057108;516.7932826869283;620.9099680546295;627.9074410525652;651.5960104735094;677.7797215904851;8150.347972162332;8172.346212303001;8374.748757537283;8537.615807288686;8669.089745576624;451.54845154845157;565.3159676791129;688.3440732785245;699.3321378083917;717.1573401253506;3881.359575669983;3939.940900886489;4037.4549435826375;4038.51537815464;4180.7909604519655;60958;61344.38655613387;61410;61428.69285653633;61430.38569614336;54927.725361373734;54984;55565;56127.71936140293;56530.43469565252;48272.51727482751;48451;48493;48532.5146748528;49010.26484602734;8295.280065405246;8321.791955201168;8531.658733650833;8573.099824518336;8763.07987661312;35381.46927796137;36175.81912090423;36322.8183859079;37074;37277;43874.12251755011;46094.76952615215;46341.07317853691;47099.52900470951;47280.290795637404;9766.414015159113;10475.16198704117;10694.572217111228;11107.888921111009;11421.200515963803;11332.376719280519;11401.828972565583;12111.576094836639;12265.26408415498;12596.55912043074;10524.842127367943;10913.890861091606;10983.685029319297;11232.943835280772;11355.772884542097;10748.731281718019;10934;11016.283941543774;11487.942560287145;11545;10428.634997775041;10473.133203197314;10475.16198704117;10624.84062739044;10858;9821.214302855611;9869.802603947737;10368.53341599645;10601.628942986958;10722.981316774894;8543.487390756574;8703.56482175876;8997.83028206329;9534.141927226583;9599.42403455795 05:05:14 INFO - PROCESS | 8876 | __end_tp_report 05:05:14 INFO - PROCESS | 8876 | __start_cc_report 05:05:14 INFO - PROCESS | 8876 | _x_x_mozilla_cycle_collect,1185 05:05:14 INFO - PROCESS | 8876 | __end_cc_report 05:05:14 INFO - PROCESS | 8876 | __startTimestamp1450789514443__endTimestamp 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | ------- Summary: start ------- 05:05:14 INFO - PROCESS | 8876 | Number of tests: 6 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | [#0] dojo.html Cycles:165 Average:5371.45 Median:5616.78 stddev:597.69 (10.6%) stddev-sans-first:572.28 05:05:14 INFO - PROCESS | 8876 | Values: 3097.3 3145.0 3174.0 3191.6 3211.2 5164.3 5298.3 5309.8 5327.7 5336.9 5275.9 5311.6 5323.2 5332.4 5432.5 4828.8 4837.2 4881.0 4964.4 4990.6 4887.6 4906.4 4951.1 4979.5 5041.5 4719.5 4797.1 4860.1 4955.3 4976.5 4955.0 4983.5 4986.6 4991.6 5009.8 4862.4 4945.7 4952.7 4956.8 4980.8 5170.3 5173.0 5275.1 5300.5 5369.8 5811.7 5866.9 5881.7 5884.3 5891.9 5886.7 5895.0 5903.9 5904.3 5910.3 5259.9 5351.6 5359.5 5376.9 5439.4 5913.6 5931.6 5937.6 5937.8 5979.9 5698.0 5698.0 5700.3 5711.4 5743.2 5575.6 5745.4 5745.7 5774.0 5843.4 5788.8 5792.7 5794.4 5796.8 5837.6 5791.3 5796.6 5799.1 5801.6 5810.0 4396.6 4483.2 4494.1 4495.1 4496.5 3946.7 4016.3 4044.1 4050.7 4052.9 5385.5 5458.4 5459.7 5489.1 5505.3 5784.9 5820.1 5823.5 5842.6 5846.6 5306.2 5388.7 5403.8 5462.9 5466.6 4930.5 5051.6 5109.2 5126.0 5160.1 5922.1 5940.7 5942.8 5943.7 5947.3 5546.8 5721.3 5832.6 5860.0 5862.6 5841.2 5881.0 5899.7 5921.2 5943.8 5625.3 5645.8 5652.1 5653.3 5753.3 5734.8 5737.3 5738.6 5742.7 5762.2 5452.2 5553.1 5554.9 5636.3 5690.9 5631.8 5716.8 5718.2 5722.7 5733.0 5616.8 5626.6 5631.6 5637.1 5642.2 5624.4 5628.9 5663.4 5714.2 5725.8 5507.4 5607.9 5630.8 5634.6 5648.5 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | [#1] ext.html Cycles:180 Average:45737.67 Median:178115.35 stddev:75820.40 (42.6%) stddev-sans-first:75957.23 05:05:14 INFO - PROCESS | 8876 | Values: 562.9 613.9 615.6 615.6 619.4 29715.1 30362.5 38273.2 38291.2 38306.8 42618.8 42953.4 42978.8 43054.0 43066.0 8747.6 8914.6 8918.9 8919.3 8924.2 7816.2 7997.0 10335.6 10540.9 10569.2 10376.8 10482.4 10483.7 10487.3 10505.6 7849.2 8021.8 10310.7 10412.2 10413.3 10432.5 10682.0 10689.3 10694.7 10702.7 39241.0 39473.8 39656.6 39714.2 39749.8 3310.9 3362.6 3696.3 3899.5 4132.6 29651.9 29818.0 30179.2 30228.1 31128.4 3391.9 3469.6 3518.9 3529.9 3631.3 281277.0 283528.0 284885.0 285200.0 285421.6 53766.5 55325.0 55501.2 56967.7 57268.0 63874.7 64085.4 64508.7 64560.7 64726.7 14824.7 15097.2 15104.6 15120.0 15131.0 10882.0 10932.7 11016.2 11016.7 11034.0 18529.4 18575.2 18713.5 18741.5 18837.0 7217.7 7497.1 7538.4 7597.0 7611.2 938.4 975.7 1006.6 1022.2 1059.6 28009.9 28206.3 28415.0 28501.2 28692.6 1039.4 1046.4 1046.6 1061.2 1068.2 14809.6 14868.5 15078.8 15089.6 15093.6 323961.0 326795.0 328577.0 328625.0 328831.0 51492.7 51816.0 51829.5 51889.0 51943.5 1308.9 1316.9 1327.9 1335.6 1337.6 27083.2 28159.3 28362.1 29296.9 30804.8 46861.8 47291.8 47346.8 47388.8 47438.0 252161.0 254181.0 254758.0 255058.0 255578.0 28023.6 28354.9 30874.1 31102.0 31500.2 40960.2 41067.8 41542.8 41966.0 42157.8 33332.3 34169.0 34397.0 34626.5 34929.8 29459.6 34833.7 35329.3 35449.6 35765.8 30125.5 33690.2 33692.5 33705.8 33765.8 28415.4 31930.4 32269.7 33845.5 35034.0 24011.3 24181.3 24384.3 24536.0 24592.6 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | [#2] jquery.html Cycles:180 Average:29626.30 Median:4027.92 stddev:94205.79 (2338.8%) stddev-sans-first:94444.39 05:05:14 INFO - PROCESS | 8876 | Values: 338.9 346.7 346.8 347.6 348.4 13657.2 14048.2 16410.9 16574.3 17372.4 15710.3 15759.6 16413.2 16415.0 16417.6 5023.7 5376.8 5385.3 5386.5 5386.7 3933.7 4026.3 4029.6 5273.9 5693.9 5739.8 5763.0 5777.3 5782.8 5791.9 5632.5 5787.4 5789.3 5796.2 5797.7 5085.1 5093.2 5095.3 5102.8 5104.7 20304.7 20855.8 21177.6 21254.4 21291.0 2162.9 2169.0 2185.6 2249.0 2636.1 8494.1 8534.7 8663.0 12558.7 13178.5 1589.9 1591.1 1597.2 1628.0 1657.4 60707.0 63448.4 64279.7 64715.0 65425.0 9302.5 9779.8 9884.7 10365.5 10506.6 12946.7 13019.7 13046.9 13047.2 13047.2 7430.8 7504.1 7532.4 7575.7 7622.8 7204.4 7223.1 7227.9 7261.9 7268.0 3920.1 4309.3 4362.1 4472.7 4505.1 1671.4 1715.1 1726.3 1727.7 1797.7 919.1 928.8 959.9 969.0 984.0 16432.7 16798.0 17074.2 17180.5 17261.4 854.6 881.6 924.8 940.7 1004.2 6714.5 9129.9 9189.4 9197.9 9466.3 556144.0 556179.0 562402.0 601870.0 604679.0 53175.5 76316.6 76842.0 85295.6 86892.6 1117.8 1137.8 1142.5 1151.7 1153.2 14396.4 15645.1 15735.4 15909.5 16068.4 35444.0 35800.8 36000.8 36763.3 37237.4 44797.8 44865.3 45924.0 47511.8 49384.5 8899.2 9137.7 9210.6 9598.1 9627.1 11263.8 11490.2 11531.4 11579.2 17190.3 13987.4 14600.3 14723.9 14780.4 15097.5 14631.3 14694.0 14991.9 15141.0 15157.8 14064.3 14143.9 14524.9 14696.8 15742.5 8377.6 8594.8 8648.8 8719.5 8743.6 9061.1 9107.9 11518.7 13844.4 14295.4 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | [#3] mootools.html Cycles:180 Average:5380.49 Median:6382.70 stddev:2817.18 (44.1%) stddev-sans-first:2808.89 05:05:14 INFO - PROCESS | 8876 | Values: 1361.8 1467.4 1509.7 1622.0 1745.4 6880.5 7428.0 7596.5 7606.0 7611.5 7616.7 7739.8 7754.2 7775.0 7783.3 1995.1 2021.7 2030.0 2154.8 2193.1 2038.4 2243.9 2258.4 2274.7 2274.9 2194.5 2197.2 2203.5 2207.9 2300.6 2241.6 2269.6 2270.9 2271.3 2272.4 2253.1 2307.9 2309.6 2310.9 2313.0 7459.2 7509.4 7530.9 7533.8 7554.2 4559.1 4641.4 4652.0 4657.9 4660.6 2997.1 3096.3 3122.2 3125.1 3144.6 891.5 906.5 914.9 953.6 973.0 10505.6 10621.1 10676.9 10770.8 10788.1 4102.8 4116.5 4155.1 4188.0 4204.7 9054.7 9076.5 9125.6 9129.5 9166.8 4497.1 4548.5 4562.6 4572.7 4573.9 4072.7 4113.6 4123.9 4129.3 4148.7 3268.2 3542.0 3545.3 3545.7 3594.0 1065.6 1088.1 1112.5 1118.6 1120.6 1011.3 1011.3 1079.1 1136.4 1293.0 7149.1 7208.4 7281.8 7293.2 7300.2 1122.2 1123.5 1130.8 1132.3 1148.7 5654.5 5704.8 5714.3 5715.0 5720.5 9115.2 9136.2 9514.6 9517.8 9528.3 9316.3 9357.8 9429.7 9431.2 9440.9 7131.5 7265.0 7299.8 7307.2 7310.6 6996.5 7028.9 7052.0 7056.9 7090.4 7914.1 8103.7 8380.5 8385.5 8409.0 8645.6 8719.9 8726.1 8737.5 8740.0 6602.4 6726.2 6752.1 6766.7 6768.1 6371.1 6722.5 7466.4 7547.6 7588.3 6793.1 6817.6 6873.7 6992.9 7021.4 6613.2 6867.5 6876.3 6960.8 6985.4 6926.1 6932.7 6963.5 6964.4 6967.9 6330.1 6354.3 6366.0 6382.4 6402.4 6322.1 6383.0 6399.6 6407.7 6436.3 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | [#4] prototype.html Cycles:180 Average:5241.02 Median:5931.64 stddev:1585.35 (26.7%) stddev-sans-first:1546.21 05:05:14 INFO - PROCESS | 8876 | Values: 322.3 325.0 327.4 328.7 329.3 5905.1 5906.8 5907.3 5929.0 5934.3 5621.6 5688.2 5772.0 5826.4 5858.6 4468.6 4479.8 4486.0 4494.3 4498.3 4275.0 4486.8 4494.6 4502.8 4507.9 4344.5 4377.5 4464.0 4473.5 4484.0 4449.2 4452.0 4468.5 4468.9 4471.9 3914.9 3917.2 3922.7 3924.3 3924.4 5499.6 5585.1 5588.0 5589.2 5591.1 5213.6 5218.8 5223.6 5227.8 5231.5 6198.4 6211.6 6216.9 6221.4 6225.4 4357.8 4362.8 4370.7 4375.2 4381.3 6320.5 6417.6 6452.2 6457.5 6462.9 4445.0 4450.6 4452.1 4453.1 4453.9 4505.2 4507.2 4510.4 4511.8 4512.3 5178.7 5199.8 5202.0 5210.9 5212.5 6121.7 6220.6 6240.7 6247.6 6274.0 1548.9 1549.8 1553.1 1553.2 1556.8 1045.5 1049.4 1067.0 1067.8 1072.8 6051.3 6056.5 6059.2 6064.2 6067.0 6469.9 6474.1 6479.1 6479.4 6480.5 5901.7 5914.1 6028.1 6098.3 6117.4 3483.8 3504.4 3518.4 3519.3 3522.8 6652.7 6657.8 6664.4 6664.5 6665.3 6549.0 6679.0 6685.8 6690.0 6692.3 6657.7 6659.1 6660.4 6664.4 6667.2 6510.3 6511.5 6516.4 6517.4 6526.1 6309.8 6442.9 6449.8 6452.9 6455.6 6613.2 6626.8 6638.6 6646.4 6648.8 4542.2 4546.0 4546.6 4550.1 4550.6 6362.8 6507.6 6522.2 6523.0 6524.6 6298.1 6341.0 6341.4 6343.1 6353.7 6324.1 6324.7 6327.2 6328.2 6333.4 6037.7 6216.8 6245.6 6255.0 6262.5 6320.3 6376.6 6398.0 6399.3 6402.5 6233.8 6238.4 6240.4 6241.6 6249.8 05:05:14 INFO - PROCESS | 8876 | 05:05:14 INFO - PROCESS | 8876 | [#5] yui.html Cycles:180 Average:14080.69 Median:48808.13 stddev:16907.62 (34.6%) stddev-sans-first:16925.39 05:05:14 INFO - PROCESS | 8876 | Values: 744.7 761.0 798.9 831.6 863.3 13269.5 13619.5 13630.1 16033.7 16250.8 14904.3 14966.7 14998.1 15005.8 15013.6 667.9 803.8 820.0 820.8 820.9 675.9 809.5 819.5 824.4 825.9 847.6 861.8 862.0 862.1 862.4 692.5 702.0 843.5 856.1 859.3 634.5 636.4 637.7 638.7 639.1 13320.5 13457.7 13564.4 13575.3 13634.3 10934.5 11252.7 11491.3 11604.8 11793.1 9408.0 9986.6 10078.2 10248.0 10322.1 3344.5 3435.4 3439.0 3449.2 3539.5 48606.0 49148.8 49210.0 49807.8 51167.5 9125.5 9154.7 9179.5 9217.4 9220.7 15755.6 15799.8 15806.5 15850.9 15863.4 6865.5 6978.2 7301.4 7395.1 7412.2 3914.3 4025.0 4137.9 4164.2 4199.1 2944.1 2975.1 2988.6 2992.4 2997.9 544.0 562.3 566.9 568.2 574.1 516.8 620.9 627.9 651.6 677.8 8150.3 8172.3 8374.7 8537.6 8669.1 451.5 565.3 688.3 699.3 717.2 3881.4 3939.9 4037.5 4038.5 4180.8 60958.0 61344.4 61410.0 61428.7 61430.4 54927.7 54984.0 55565.0 56127.7 56530.4 48272.5 48451.0 48493.0 48532.5 49010.3 8295.3 8321.8 8531.7 8573.1 8763.1 35381.5 36175.8 36322.8 37074.0 37277.0 43874.1 46094.8 46341.1 47099.5 47280.3 9766.4 10475.2 10694.6 11107.9 11421.2 11332.4 11401.8 12111.6 12265.3 12596.6 10524.8 10913.9 10983.7 11232.9 11355.8 10748.7 10934.0 11016.3 11487.9 11545.0 10428.6 10473.1 10475.2 10624.8 10858.0 9821.2 9869.8 10368.5 10601.6 10723.0 8543.5 8703.6 8997.8 9534.1 9599.4 05:05:14 INFO - PROCESS | 8876 | -------- Summary: end -------- 05:05:14 INFO - PROCESS | 8876 | 05:05:15 INFO - TEST-INFO | 8876: exit 0 05:05:15 INFO - TEST-OK | dromaeo_css | took 1113426ms 05:05:15 INFO - TEST-START | kraken 05:05:15 INFO - operating with platform_type : linux_ 05:05:15 INFO - Initialising browser for kraken test... 05:05:15 INFO - TEST-INFO | started process 9070 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmEhYdY/profile http://localhost:35482/getInfo.html) 05:05:19 INFO - PROCESS | 9070 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:05:19 INFO - PROCESS | 9070 | __metrics Screen width/height:1600/1200 05:05:19 INFO - PROCESS | 9070 | colorDepth:24 05:05:19 INFO - PROCESS | 9070 | Browser inner width/height: 1024/697 05:05:19 INFO - PROCESS | 9070 | __metrics 05:05:19 INFO - PROCESS | 9070 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:05:19 INFO - PROCESS | 9070 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:20 INFO - TEST-INFO | 9070: exit 0 05:05:20 INFO - Browser initialized. 05:05:20 INFO - Running cycle 1/1 for kraken test... 05:05:20 INFO - TEST-INFO | started process 9151 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmEhYdY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:32 INFO - PROCESS | 9151 | RSS: Main: 151232512 05:05:32 INFO - PROCESS | 9151 | 05:05:34 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35482/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:35 INFO - PROCESS | 9151 | RSS: Main: 186228736 05:05:35 INFO - PROCESS | 9151 | 05:05:37 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35482/tests/kraken/driver.html?testName=audio-dft) 05:05:38 INFO - PROCESS | 9151 | RSS: Main: 177627136 05:05:38 INFO - PROCESS | 9151 | 05:05:41 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35482/tests/kraken/driver.html?testName=audio-fft) 05:05:41 INFO - PROCESS | 9151 | RSS: Main: 159457280 05:05:41 INFO - PROCESS | 9151 | 05:05:43 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35482/tests/kraken/driver.html?testName=audio-oscillator) 05:05:44 INFO - PROCESS | 9151 | RSS: Main: 162840576 05:05:44 INFO - PROCESS | 9151 | 05:05:46 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:47 INFO - PROCESS | 9151 | RSS: Main: 164782080 05:05:47 INFO - PROCESS | 9151 | 05:05:50 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35482/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:50 INFO - PROCESS | 9151 | RSS: Main: 164737024 05:05:50 INFO - PROCESS | 9151 | 05:05:54 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35482/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:54 INFO - PROCESS | 9151 | RSS: Main: 166850560 05:05:54 INFO - PROCESS | 9151 | 05:05:57 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35482/tests/kraken/driver.html?testName=json-parse-financial) 05:05:57 INFO - PROCESS | 9151 | RSS: Main: 165953536 05:05:57 INFO - PROCESS | 9151 | 05:05:59 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:00 INFO - PROCESS | 9151 | RSS: Main: 178532352 05:06:00 INFO - PROCESS | 9151 | 05:06:01 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:02 INFO - PROCESS | 9151 | RSS: Main: 173821952 05:06:02 INFO - PROCESS | 9151 | 05:06:04 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:05 INFO - PROCESS | 9151 | RSS: Main: 188502016 05:06:05 INFO - PROCESS | 9151 | 05:06:07 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:08 INFO - PROCESS | 9151 | RSS: Main: 194002944 05:06:08 INFO - PROCESS | 9151 | 05:06:10 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:11 INFO - PROCESS | 9151 | RSS: Main: 192847872 05:06:11 INFO - PROCESS | 9151 | 05:06:12 INFO - PROCESS | 9151 | Cycle 1(1): loaded http://localhost:35482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35482/tests/kraken/driver.html?testName=ai-astar) 05:06:13 INFO - PROCESS | 9151 | RSS: Main: 249982976 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | __start_tp_report 05:06:13 INFO - PROCESS | 9151 | _x_x_mozilla_page_load 05:06:13 INFO - PROCESS | 9151 | _x_x_mozilla_page_load_details 05:06:13 INFO - PROCESS | 9151 | |i|pagename|runs| 05:06:13 INFO - PROCESS | 9151 | |0;ai-astar;107;110;104;112;109;110;102;111;110;116 05:06:13 INFO - PROCESS | 9151 | |1;audio-beat-detection;150;125;150;169;124;149;150;124;159;125 05:06:13 INFO - PROCESS | 9151 | |2;audio-dft;162;161;159;160;160;161;160;162;160;162 05:06:13 INFO - PROCESS | 9151 | |3;audio-fft;73;72;86;97;71;71;71;92;89;72 05:06:13 INFO - PROCESS | 9151 | |4;audio-oscillator;93;93;136;93;93;94;138;93;93;142 05:06:13 INFO - PROCESS | 9151 | |5;imaging-gaussian-blur;110;110;110;110;110;111;110;109;110;109 05:06:13 INFO - PROCESS | 9151 | |6;imaging-darkroom;146;146;145;145;146;145;146;146;145;145 05:06:13 INFO - PROCESS | 9151 | |7;imaging-desaturate;96;95;95;96;96;96;96;96;95;95 05:06:13 INFO - PROCESS | 9151 | |8;json-parse-financial;57;57;57;55;56;57;59;64;55;55 05:06:13 INFO - PROCESS | 9151 | |9;json-stringify-tinderbox;66;67;66;66;67;67;67;77;70;66 05:06:13 INFO - PROCESS | 9151 | |10;stanford-crypto-aes;83;85;83;94;84;84;85;85;85;85 05:06:13 INFO - PROCESS | 9151 | |11;stanford-crypto-ccm;122;124;122;117;113;112;114;122;116;122 05:06:13 INFO - PROCESS | 9151 | |12;stanford-crypto-pbkdf2;140;152;148;151;151;141;148;149;147;140 05:06:13 INFO - PROCESS | 9151 | |13;stanford-crypto-sha256-iterative;66;67;66;67;67;65;65;65;66;65 05:06:13 INFO - PROCESS | 9151 | __end_tp_report 05:06:13 INFO - PROCESS | 9151 | __start_cc_report 05:06:13 INFO - PROCESS | 9151 | _x_x_mozilla_cycle_collect,936 05:06:13 INFO - PROCESS | 9151 | __end_cc_report 05:06:13 INFO - PROCESS | 9151 | __startTimestamp1450789573088__endTimestamp 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | ------- Summary: start ------- 05:06:13 INFO - PROCESS | 9151 | Number of tests: 14 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.98 (3.6%) stddev-sans-first:4.15 05:06:13 INFO - PROCESS | 9151 | Values: 107.0 110.0 104.0 112.0 109.0 110.0 102.0 111.0 110.0 116.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:150.00 stddev:16.61 (11.1%) stddev-sans-first:17.39 05:06:13 INFO - PROCESS | 9151 | Values: 150.0 125.0 150.0 169.0 124.0 149.0 150.0 124.0 159.0 125.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 05:06:13 INFO - PROCESS | 9151 | Values: 162.0 161.0 159.0 160.0 160.0 161.0 160.0 162.0 160.0 162.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#3] audio-fft Cycles:10 Average:79.40 Median:79.50 stddev:10.36 (13.0%) stddev-sans-first:10.73 05:06:13 INFO - PROCESS | 9151 | Values: 73.0 72.0 86.0 97.0 71.0 71.0 71.0 92.0 89.0 72.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.04 (23.7%) stddev-sans-first:22.80 05:06:13 INFO - PROCESS | 9151 | Values: 93.0 93.0 136.0 93.0 93.0 94.0 138.0 93.0 93.0 142.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:06:13 INFO - PROCESS | 9151 | Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 109.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:06:13 INFO - PROCESS | 9151 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:06:13 INFO - PROCESS | 9151 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:2.70 (4.7%) stddev-sans-first:2.86 05:06:13 INFO - PROCESS | 9151 | Values: 57.0 57.0 57.0 55.0 56.0 57.0 59.0 64.0 55.0 55.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.00 stddev:3.41 (5.1%) stddev-sans-first:3.55 05:06:13 INFO - PROCESS | 9151 | Values: 66.0 67.0 66.0 66.0 67.0 67.0 67.0 77.0 70.0 66.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:3.16 (3.7%) stddev-sans-first:3.24 05:06:13 INFO - PROCESS | 9151 | Values: 83.0 85.0 83.0 94.0 84.0 84.0 85.0 85.0 85.0 85.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:122.00 stddev:4.48 (3.7%) stddev-sans-first:4.56 05:06:13 INFO - PROCESS | 9151 | Values: 122.0 124.0 122.0 117.0 113.0 112.0 114.0 122.0 116.0 122.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:148.50 stddev:4.67 (3.1%) stddev-sans-first:4.28 05:06:13 INFO - PROCESS | 9151 | Values: 140.0 152.0 148.0 151.0 151.0 141.0 148.0 149.0 147.0 140.0 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - PROCESS | 9151 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 05:06:13 INFO - PROCESS | 9151 | Values: 66.0 67.0 66.0 67.0 67.0 65.0 65.0 65.0 66.0 65.0 05:06:13 INFO - PROCESS | 9151 | -------- Summary: end -------- 05:06:13 INFO - PROCESS | 9151 | 05:06:13 INFO - TEST-INFO | 9151: exit 0 05:06:13 INFO - TEST-OK | kraken | took 58748ms 05:06:13 INFO - TEST-START | v8_7 05:06:13 INFO - operating with platform_type : linux_ 05:06:13 INFO - Initialising browser for v8_7 test... 05:06:13 INFO - TEST-INFO | started process 9403 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkcvvJP/profile http://localhost:35482/getInfo.html) 05:06:18 INFO - PROCESS | 9403 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:06:18 INFO - PROCESS | 9403 | __metrics Screen width/height:1600/1200 05:06:18 INFO - PROCESS | 9403 | colorDepth:24 05:06:18 INFO - PROCESS | 9403 | Browser inner width/height: 1024/697 05:06:18 INFO - PROCESS | 9403 | __metrics 05:06:18 INFO - PROCESS | 9403 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:06:18 INFO - PROCESS | 9403 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:19 INFO - TEST-INFO | 9403: exit 0 05:06:19 INFO - Browser initialized. 05:06:19 INFO - Running cycle 1/1 for v8_7 test... 05:06:19 INFO - TEST-INFO | started process 9484 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkcvvJP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:31 INFO - PROCESS | 9484 | RSS: Main: 149721088 05:06:31 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | Cycle 1(1): loaded http://localhost:35482/tests/v8_7/run.html (next: http://localhost:35482/tests/v8_7/run.html) 05:06:52 INFO - PROCESS | 9484 | RSS: Main: 615116800 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | __start_tp_report 05:06:52 INFO - PROCESS | 9484 | _x_x_mozilla_page_load 05:06:52 INFO - PROCESS | 9484 | _x_x_mozilla_page_load_details 05:06:52 INFO - PROCESS | 9484 | |i|pagename|runs| 05:06:52 INFO - PROCESS | 9484 | |0;Richards;168.37851490149856 05:06:52 INFO - PROCESS | 9484 | |1;DeltaBlue;188.46588767433096 05:06:52 INFO - PROCESS | 9484 | |2;Encrypt;280.19052956010086 05:06:52 INFO - PROCESS | 9484 | |3;Decrypt;5208.333333333333 05:06:52 INFO - PROCESS | 9484 | |4;RayTrace;1089.3246187363834 05:06:52 INFO - PROCESS | 9484 | |5;Earley;779.423226812159 05:06:52 INFO - PROCESS | 9484 | |6;Boyer;12280.487804878048 05:06:52 INFO - PROCESS | 9484 | |7;RegExp;26230.76923076923 05:06:52 INFO - PROCESS | 9484 | |8;Splay;692.5722145804676 05:06:52 INFO - PROCESS | 9484 | |9;NavierStokes;4850.241545893719 05:06:52 INFO - PROCESS | 9484 | __end_tp_report 05:06:52 INFO - PROCESS | 9484 | __startTimestamp1450789612748__endTimestamp 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | ------- Summary: start ------- 05:06:52 INFO - PROCESS | 9484 | Number of tests: 10 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#0] Richards Cycles:1 Average:168.38 Median:168.38 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 168.4 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#1] DeltaBlue Cycles:1 Average:188.47 Median:188.47 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 188.5 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 280.2 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 5208.3 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#4] RayTrace Cycles:1 Average:1089.32 Median:1089.32 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 1089.3 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 779.4 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 12280.5 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 26230.8 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#8] Splay Cycles:1 Average:692.57 Median:692.57 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 692.6 05:06:52 INFO - PROCESS | 9484 | 05:06:52 INFO - PROCESS | 9484 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 05:06:52 INFO - PROCESS | 9484 | Values: 4850.2 05:06:52 INFO - PROCESS | 9484 | -------- Summary: end -------- 05:06:52 INFO - PROCESS | 9484 | 05:06:53 INFO - TEST-INFO | 9484: exit 0 05:06:53 INFO - TEST-OK | v8_7 | took 39585ms 05:06:53 INFO - SUITE-END | took 1211s 05:06:53 INFO - Completed test suite (00:20:11) 05:06:53 INFO - Working with test: dromaeo_css 05:06:53 INFO - Generating results file: dromaeo_css 05:06:53 INFO - Working with test: kraken 05:06:53 INFO - Generating results file: kraken 05:06:53 INFO - javascript benchmark 05:06:53 INFO - Working with test: v8_7 05:06:53 INFO - Generating results file: v8_7 05:06:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:06:53 INFO - process_Request line: dromaeo_css 6930.84 graph.html#tests=[[72,64,35]] 05:06:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:53 INFO - process_Request line: kraken 1490.90 graph.html#tests=[[232,64,35]] 05:06:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:53 INFO - process_Request line: v8_7 20731.09 graph.html#tests=[[230,64,35]] 05:06:53 INFO - RETURN: dromaeo_css: 6930.84 05:06:53 INFO - RETURN: kraken: 1490.90 05:06:53 INFO - RETURN: v8_7: 20731.09 05:06:53 INFO - javascript benchmark 05:06:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3097.30310680097, 3144.9842750786243, 3173.9841300793505, 3191.601049868765, 3211.2132527530744, 5164.328637277149, 5298.284731561238, 5309.761060752266, 5327.653702509334, 5336.866578335539, 5275.868103297419, 5311.601629877755, 5323.1749078892735, 5332.413434522209, 5432.538234250083, 4828.7585620719, 4837.153498137829, 4880.999395123991, 4964.379452568429, 4990.600751939836, 4887.6089912807065, 4906.362172917516, 4951.133551628469, 4979.50204979501, 5041.52105549974, 4719.480857105716, 4797.11253418117, 4860.125177468054, 4955.306257124005, 4976.527229913152, 4955.0, 4983.451820299764, 4986.626003049786, 4991.575716064139, 5009.824656137018, 4862.44081930579, 4945.67853089548, 4952.702837829742, 4956.801727930879, 4980.7509624518625, 5170.250313704491, 5173.0, 5275.129603615399, 5300.496452836975, 5369.812056578001, 5811.6803575803315, 5866.853328666774, 5881.735321910524, 5884.264466941632, 5891.882162356772, 5886.735096920606, 5894.997850365448, 5903.940960590382, 5904.291485021782, 5910.261217347832, 5259.894802103937, 5351.625386222966, 5359.5444387227135, 5376.91934620981, 5439.428859969726, 5913.586048976616, 5931.584789064724, 5937.554683398763, 5937.82186534396, 5979.880402391927, 5698.031334673115, 5698.031334673115, 5700.287464066992, 5711.400302968212, 5743.167240750068, 5575.581831362664, 5745.425457454221, 5745.712714364265, 5774.0, 5843.357230704619, 5788.82633520995, 5792.652440853562, 5794.362620111784, 5796.797112101056, 5837.620554663933, 5791.3339965903615, 5796.62321949072, 5799.072148456226, 5801.622894511927, 5809.970950145223, 4396.560343965642, 4483.21543729846, 4494.12364588902, 4495.056038231943, 4496.460424749051, 3946.703997200164, 4016.256992456405, 4044.0698639313123, 4050.675945924319, 4052.858149964737, 5385.542228910508, 5458.426865179178, 5459.69971651555, 5489.149181876815, 5505.256790333334, 5784.88430231393, 5820.097884827858, 5823.5341172706085, 5842.5618078644275, 5846.619969701956, 5306.177542480922, 5388.741538339721, 5403.7838486460105, 5462.863428414322, 5466.644668096561, 4930.482299358588, 5051.646384753032, 5109.156989096758, 5126.0, 5160.09698302803, 5922.111683247547, 5940.70296485174, 5942.762289508371, 5943.70281485924, 5947.256592925884, 5546.778128874961, 5721.256236689203, 5832.562557808096, 5859.970700146472, 5862.618929769551, 5841.153032810304, 5881.0, 5899.67551784656, 5921.230240068763, 5943.791967281124, 5625.324961004706, 5645.802396916252, 5652.123920792284, 5653.293338332708, 5753.280839895013, 5734.827955161351, 5737.282839645044, 5738.626989245686, 5742.712864356682, 5762.222100016612, 5452.182172674131, 5553.0559804832465, 5554.861128471659, 5636.323641163087, 5690.886182276414, 5631.802886898939, 5716.771329146954, 5718.1708652246025, 5722.742476588647, 5733.0, 5616.775328986795, 5626.5780066496, 5631.63394379364, 5637.069883469346, 5642.181883626769, 5624.381318054929, 5628.943710562842, 5663.405342438985, 5714.171445140514, 5725.799597014085, 5507.394186639546, 5607.859803504945, 5630.8029218977135, 5634.577406694432, 5648.4633959773755], "unit": "score", "name": "dojo.html", "value": 5332.212968418112}, {"lowerIsBetter": false, "replicates": [562.9240052592901, 613.880293342798, 615.5844804756788, 615.6121643364679, 619.3837132053608, 29715.108546743606, 30362.544561831564, 38273.234535309275, 38291.234175316546, 38306.8084659577, 42618.78690606551, 42953.35569966453, 42978.78510607443, 43054.0, 43066.0, 8747.562621868912, 8914.643414263423, 8918.910810891904, 8919.28645708345, 8924.196822285992, 7816.17930117338, 7996.960015199916, 10335.638252661158, 10540.947295263513, 10569.154467642571, 10376.792464150712, 10482.371057736522, 10483.68548943533, 10487.265891387606, 10505.579776808918, 7849.215078492105, 8021.839563208761, 10310.690679279596, 10412.219083568763, 10413.271071025032, 10432.478376081166, 10682.03861652455, 10689.251752377337, 10694.732631684192, 10702.678919632424, 39241.03794810248, 39473.802630986946, 39656.60343396558, 39714.20571588581, 39749.80125099385, 3310.8841190558214, 3362.5796775403073, 3696.2792255510185, 3899.5320561532512, 4132.648724858391, 29651.851740741375, 29818.0, 30179.245518862204, 30228.09315720532, 31128.377432451223, 3391.9491207631904, 3469.61834198238, 3518.9120271993147, 3529.876454324112, 3631.346357655621, 281277.0, 283528.0, 284885.0, 285200.0, 285421.5728921363, 53766.46233537615, 55325.0, 55501.16748248779, 56967.71516142393, 57268.0, 63874.68062659657, 64085.359146407936, 64508.677456612415, 64560.67719661372, 64726.676366618805, 14824.703505929821, 15097.245137743288, 15104.622384440478, 15120.0, 15131.0, 10882.0, 10932.726681833017, 11016.17378696585, 11016.669499915015, 11034.006939375495, 18529.351472698392, 18575.16411761474, 18713.53216169607, 18741.531461713566, 18837.0, 7217.7473788417155, 7497.10034795828, 7538.434617403716, 7597.0, 7611.238876112345, 938.3525367496405, 975.7463059604554, 1006.6325791086201, 1022.1669339488293, 1059.6026490066224, 28009.859950700116, 28206.294842629097, 28415.0, 28501.15525080139, 28692.569611455845, 1039.3504059962524, 1046.3564907581783, 1046.5604446132643, 1061.1881910338598, 1068.150820098024, 14809.62975925589, 14868.479603214051, 15078.849211507964, 15089.622759431102, 15093.622659433382, 323961.0, 326795.0, 328577.0, 328625.0, 328831.0, 51492.74253628783, 51816.0, 51829.48170518322, 51889.0, 51943.48056519462, 1308.9214647121203, 1316.8814806667447, 1327.8672132786644, 1335.5525898823807, 1337.612092493166, 27083.1875043749, 28159.296017599725, 28362.149135525968, 29296.853515732284, 30804.75557745242, 46861.76569117133, 47291.76354118345, 47346.76326618345, 47388.7630561845, 47438.0, 252161.0, 254181.0, 254758.0, 255058.0, 255578.0, 28023.579646304916, 28354.85822570874, 30874.073777786703, 31102.0, 31500.212494687818, 40960.1807963845, 41067.794661026506, 41542.792286039585, 41966.0, 42157.78921105375, 33332.333353333284, 34169.0, 34397.0, 34626.48060279048, 34929.825350873085, 29459.55810662799, 34833.65166348304, 35329.29341413209, 35449.64550354567, 35765.82117089398, 30125.548116778704, 33690.157746056546, 33692.49461258132, 33705.83147084249, 33765.83117084399, 28415.43169136647, 31930.36139277155, 32269.692990558622, 33845.492317615746, 35034.0, 24011.27966161018, 24181.274561763174, 24384.26847194587, 24536.0, 24592.631110533], "unit": "score", "name": "ext.html", "value": 18460.35939245809}, {"lowerIsBetter": false, "replicates": [338.87461639193504, 346.6516151267977, 346.7763292676224, 347.5933158204901, 348.4285771335013, 13657.180569165857, 14048.227347495884, 16410.917945410285, 16574.254158562864, 17372.391966281182, 15710.293036813342, 15759.60600984976, 16413.17934103296, 16415.0, 16417.589560261, 5023.748812559366, 5376.838694839161, 5385.299911011563, 5386.461353864622, 5386.730663466811, 3933.6656384207236, 4026.2752704513177, 4029.5567487576345, 5273.86815329616, 5693.886122277573, 5739.799107031255, 5763.049096899007, 5777.335606405275, 5782.826515204551, 5791.855203619901, 5632.549396048326, 5787.392323806003, 5789.305283365981, 5796.2464879565805, 5797.681127537984, 5085.1355269604255, 5093.159628661267, 5095.286659867622, 5102.846914592568, 5104.69371837691, 20304.69542956857, 20855.791442085538, 21177.576448470943, 21254.36236912895, 21291.0, 2162.859414138076, 2168.98915505423, 2185.5519618478174, 2249.0, 2636.1003144109204, 8494.108118647515, 8534.658613655509, 8663.0, 12558.74882502345, 13178.472861085545, 1589.9205039748083, 1591.1328326062207, 1597.177453611391, 1628.0077068988603, 1657.3709915496859, 60707.0, 63448.365516344704, 64279.678601607164, 64715.0, 65425.0, 9302.53487325631, 9779.755506112404, 9884.654037108667, 10365.533550990072, 10506.632267870587, 12946.67633309156, 13019.739605208033, 13046.869531304756, 13047.151935124186, 13047.217166970013, 7430.814229644302, 7504.061992250969, 7532.359749421361, 7575.734849280248, 7622.771316860503, 7204.387627051759, 7223.097112860893, 7227.927720722725, 7261.947017682406, 7268.018817459681, 3920.0591857953887, 4309.267424537836, 4362.083962367875, 4472.709273897186, 4505.053938672915, 1671.4400675773752, 1715.1424287856073, 1726.3181043487753, 1727.7494763259258, 1797.694391953371, 919.1268295119529, 928.8374534456443, 959.9184069354183, 968.9951550242204, 983.9901600984042, 16432.671346573003, 16798.0, 17074.2316595751, 17180.484585462455, 17261.3958511454, 854.5641722721457, 881.6209030116983, 924.8104138651561, 940.7168980258847, 1004.1615251265275, 6714.462842972551, 9129.895835415991, 9189.356745027917, 9197.908020919838, 9466.29002824791, 556144.0, 556179.0, 562402.0, 601870.0, 604679.0, 53175.468245317825, 76316.61841690756, 76842.0, 85295.57352213199, 86892.5655371719, 1117.7708569743345, 1137.789508940832, 1142.4630423700846, 1151.7235863392725, 1153.1754795321217, 14396.352164152848, 15645.139517326656, 15735.44925927587, 15909.522714318126, 16068.35726570924, 35444.0, 35800.8209958959, 36000.81999589985, 36763.26473470462, 37237.441438378984, 44797.776011119735, 44865.327020094075, 45924.0, 47511.76244118757, 49384.50615493799, 8899.199072083544, 9137.725868223964, 9210.631574736935, 9598.136167744937, 9627.133557979816, 11263.831042534532, 11490.195686301879, 11531.423428828693, 11579.24734892263, 17190.31238750436, 13987.370568324654, 14600.342984565932, 14723.926380368459, 14780.408783648534, 15097.47158849435, 14631.268436577915, 14694.0, 14991.850081499046, 15141.0, 15157.848421515644, 14064.296785160497, 14143.929280353945, 14524.927375363055, 14696.779548306999, 15742.527724168292, 8377.623006964823, 8594.78513037179, 8648.827023459622, 8719.52042637661, 8743.644735066075, 9061.093890610886, 9107.908920910706, 11518.654440366803, 13844.37700303509, 14295.428182872569], "unit": "score", "name": "jquery.html", "value": 8679.693928031958}, {"lowerIsBetter": false, "replicates": [1361.836579610447, 1467.3983666696654, 1509.7282489151955, 1621.9594510137244, 1745.4152858792297, 6880.483963702717, 7427.962860185698, 7596.544207347549, 7605.999999999993, 7611.467197296191, 7616.7334143305, 7739.845203095934, 7754.2245775422425, 7775.0, 7783.299503044725, 1995.0922330339733, 2021.6866385710239, 2030.0458784371322, 2154.7845215478483, 2193.111789725164, 2038.3986723916405, 2243.932682019542, 2258.424101854025, 2274.7042884425, 2274.863508189514, 2194.47332640166, 2197.187040794908, 2203.5372571759867, 2207.9116835326568, 2300.5628930503235, 2241.607718649238, 2269.5914735347715, 2270.8751018694047, 2271.3299576624936, 2272.397814579138, 2253.1438053539714, 2307.86152830829, 2309.6304591265484, 2310.9306720798404, 2312.9653055204185, 7459.216782237895, 7509.436792240549, 7530.924690753077, 7533.849323013564, 7554.244575542457, 4559.088182363507, 4641.373414589021, 4651.953480465186, 4657.906841863178, 4660.557247061523, 2997.14581344318, 3096.3342881280632, 3122.172624254574, 3125.0937228203793, 3144.591203143577, 891.4784850862253, 906.5240748606968, 914.862770584411, 953.5708930981017, 972.9805403891883, 10505.579776808918, 10621.097206737437, 10676.946615266952, 10770.78458430827, 10788.136949044057, 4102.794860257035, 4116.526599441043, 4155.106652069759, 4187.97906010468, 4204.726692764961, 9054.683086091954, 9076.455412675261, 9125.634974600942, 9129.452232865917, 9166.770830729285, 4497.055618320124, 4548.499665036843, 4562.5665561771575, 4572.6799124061, 4573.885652858705, 4072.714909956275, 4113.609207125318, 4123.8969025773995, 4129.339305711132, 4148.730332528376, 3268.150280926976, 3541.964580354215, 3545.3263879862743, 3545.6808887200277, 3594.0475773919934, 1065.5631191211567, 1088.1240601315858, 1112.477135746198, 1118.6476259978244, 1120.618989543559, 1011.2668315471225, 1011.3476807459294, 1079.1474734959295, 1136.3693150301497, 1293.049608537724, 7149.106361704787, 7208.387287080552, 7281.817954551073, 7293.161286452126, 7300.233475485104, 1122.2424863217295, 1123.5225029362653, 1130.8303754436736, 1132.297975255347, 1148.7472755993667, 5654.547636189095, 5704.80033198836, 5714.257146570919, 5714.9714251429305, 5720.485156335866, 9115.225205857443, 9136.177744003071, 9514.619415223451, 9517.762055948519, 9528.285378596633, 9316.254699624149, 9357.766055848659, 9429.717108486757, 9431.245500359955, 9440.858387124199, 7131.465140114512, 7265.0, 7299.817504562322, 7307.2327405621645, 7310.634468276565, 6996.545224560387, 7028.859422811617, 7052.0479735235085, 7056.894146587908, 7090.361867431956, 7914.089879663912, 8103.675852966051, 8380.455270407405, 8385.538795366314, 8409.0, 8645.610947507503, 8719.91280087191, 8726.127387261224, 8737.475751454933, 8739.956300218459, 6602.438792702674, 6726.192856857013, 6752.088468056946, 6766.661666916733, 6768.052472653734, 6371.076193951758, 6722.462203023649, 7466.36535894455, 7547.5848828314965, 7588.27911348421, 6793.116894803644, 6817.5568588041615, 6873.690683919136, 6992.895106573507, 7021.4031807294905, 6613.2394774601535, 6867.519273650796, 6876.312368763083, 6960.825979350354, 6985.441164706913, 6926.099607051051, 6932.653367331714, 6963.547369420971, 6964.408025317702, 6967.860642787217, 6330.082138090043, 6354.332795056453, 6366.0, 6382.36176382358, 6402.35976402356, 6322.114903913363, 6383.042543618494, 6399.55203135776, 6407.743690252338, 6436.259830119596], "unit": "score", "name": "mootools.html", "value": 4401.929129207331}, {"lowerIsBetter": false, "replicates": [322.27166603476144, 325.0314064089015, 327.4008564327281, 328.6729703944575, 329.2805220593003, 5905.055191169419, 5906.793262235823, 5907.320658124317, 5929.0, 5934.287885453741, 5621.634593751413, 5688.175214593882, 5771.961047011547, 5826.4173582641715, 5858.648481091138, 4468.575485328888, 4479.820807167709, 4486.035502366991, 4494.258447356182, 4498.257787465081, 4274.97862510687, 4486.775661216942, 4494.5730155635165, 4502.752348620825, 4507.909841803162, 4344.45694288214, 4377.540358262384, 4463.955360446403, 4473.485549161839, 4483.977580112111, 4449.2213862574245, 4452.042810795679, 4468.463784345867, 4468.865934021952, 4471.865844024668, 3914.941275880864, 3917.216556688674, 3922.666573341269, 3924.31324518211, 3924.3721004639406, 5499.615026948115, 5585.106382978704, 5587.972060139673, 5589.217509548666, 5591.133374326986, 5213.635045546814, 5218.817341393071, 5223.555997740196, 5227.843164705065, 5231.476852314738, 6198.3801619838105, 6211.596246243979, 6216.906746398808, 6221.440070393686, 6225.3774622537385, 4357.84747533838, 4362.847300344472, 4370.715903466296, 4375.2124617568825, 4381.298992161271, 6320.525960552931, 6417.614943103429, 6452.161219041542, 6457.515686323498, 6462.870742585122, 4445.044315472124, 4450.577195166454, 4452.131834292347, 4453.131639330364, 4453.866384008485, 4505.211587972091, 4507.166174257707, 4510.391097201901, 4511.796969136397, 4512.2554778461845, 5178.663386879841, 5199.804045069655, 5202.0, 5210.895782084337, 5212.50481204285, 6121.663308517986, 6220.564560480723, 6240.687965601702, 6247.5939063960695, 6274.0, 1548.899321544096, 1549.7907782449452, 1553.0914415067311, 1553.1923399832024, 1556.8209655889718, 1045.482486169351, 1049.4490392543976, 1066.9543847029954, 1067.802456545526, 1072.769354588767, 6051.334353221142, 6056.515478761777, 6059.1820104286235, 6064.151018857276, 6066.969665151646, 6469.935300647027, 6474.093626892239, 6479.092926990225, 6479.449246814073, 6480.51396145291, 5901.734421951022, 5914.142449344907, 6028.065649824284, 6098.26820781509, 6117.388261173847, 3483.808390538494, 3504.351694936445, 3518.4370500720274, 3519.331327047853, 3522.7534072615185, 6652.73389064432, 6657.833554161185, 6664.400203981665, 6664.500162487736, 6665.300143484961, 6549.0, 6679.031540426611, 6685.832854178684, 6690.0, 6692.330766923366, 6657.667116644148, 6659.067730517731, 6660.400563949268, 6664.400203981665, 6667.19993600771, 6510.316416776171, 6511.544191906521, 6516.380943810331, 6517.4134327910715, 6526.086347911201, 6309.842253943688, 6442.935570644234, 6449.806505804833, 6452.935470645233, 6455.580387274812, 6613.173353330833, 6626.83432914181, 6638.601683898982, 6646.368594983469, 6648.767293144717, 4542.1824071667415, 4545.954540454553, 4546.568076032771, 4550.13547425988, 4550.590446859666, 6362.809115726535, 6507.609543427409, 6522.184726909137, 6523.0, 6524.641144737085, 6298.08677741734, 6340.968295158495, 6341.365863413806, 6343.111964324906, 6353.682315884095, 6324.083007963912, 6324.747010119544, 6327.209098862642, 6328.240611126695, 6333.429991300805, 6037.667928263988, 6216.813495595139, 6245.594036387621, 6255.0, 6262.53031022666, 6320.273168585672, 6376.649284289409, 6398.0, 6399.2640846303275, 6402.455791257609, 6233.75064997395, 6238.407351301619, 6240.438360547572, 6241.594296370721, 6249.843753906007], "unit": "score", "name": "prototype.html", "value": 4722.121064197473}, {"lowerIsBetter": false, "replicates": [744.7393412305692, 760.9695612175511, 798.9241022102901, 831.6091437024596, 863.3266052479069, 13269.469221231151, 13619.523316683919, 13630.114042587225, 16033.679326413465, 16250.83749162508, 14904.254787260648, 14966.700665986673, 14998.100113993169, 15005.84994150058, 15013.624659383493, 667.8797816393047, 803.7789607857842, 819.971301004465, 820.7660816667251, 820.8604537228686, 675.8614484030786, 809.5142914251431, 819.5001049359886, 824.381713714714, 825.9297959673435, 847.6058632735777, 861.8104017116225, 862.0431321233426, 862.1292494580456, 862.4264863865521, 692.4737199728193, 702.0311969482082, 843.5360551696604, 856.1181982557944, 859.2996707683218, 634.4892361648871, 636.3954243468677, 637.6843462486099, 638.7285403703454, 639.0797251957167, 13320.467181312735, 13457.730845383136, 13564.389602467912, 13575.321233938264, 13634.318284085755, 10934.507947142398, 11252.718682033015, 11491.253068550517, 11604.825927611093, 11793.115516336224, 9407.952960235223, 9986.550605222783, 10078.244131690153, 10248.0, 10322.122619577345, 3344.5484859543894, 3435.4331535296647, 3439.008609963664, 3449.189440481485, 3539.50446937429, 48606.0, 49148.75425622885, 49210.0, 49807.750961244965, 51167.48832511665, 9125.543364733288, 9154.67958621445, 9179.495127767903, 9217.400868943498, 9220.723378298662, 15755.606109847346, 15799.763003554956, 15806.525804225892, 15850.920745396199, 15863.365465381487, 6865.450763938873, 6978.232394436608, 7301.379382752525, 7395.112586489656, 7412.221716719775, 3914.2954268231993, 4025.0, 4137.8758637240935, 4164.167166566699, 4199.0552125772065, 2944.131481213047, 2975.1074677596635, 2988.581598576201, 2992.356643321696, 2997.860812891131, 543.9510444060054, 562.3083607163212, 566.8554518597731, 568.2186992884783, 574.1072632057108, 516.7932826869283, 620.9099680546295, 627.9074410525652, 651.5960104735094, 677.7797215904851, 8150.347972162332, 8172.346212303001, 8374.748757537283, 8537.615807288686, 8669.089745576624, 451.54845154845157, 565.3159676791129, 688.3440732785245, 699.3321378083917, 717.1573401253506, 3881.359575669983, 3939.940900886489, 4037.4549435826375, 4038.51537815464, 4180.7909604519655, 60958.0, 61344.38655613387, 61410.0, 61428.69285653633, 61430.38569614336, 54927.725361373734, 54984.0, 55565.0, 56127.71936140293, 56530.43469565252, 48272.51727482751, 48451.0, 48493.0, 48532.5146748528, 49010.26484602734, 8295.280065405246, 8321.791955201168, 8531.658733650833, 8573.099824518336, 8763.07987661312, 35381.46927796137, 36175.81912090423, 36322.8183859079, 37074.0, 37277.0, 43874.12251755011, 46094.76952615215, 46341.07317853691, 47099.52900470951, 47280.290795637404, 9766.414015159113, 10475.16198704117, 10694.572217111228, 11107.888921111009, 11421.200515963803, 11332.376719280519, 11401.828972565583, 12111.576094836639, 12265.26408415498, 12596.55912043074, 10524.842127367943, 10913.890861091606, 10983.685029319297, 11232.943835280772, 11355.772884542097, 10748.731281718019, 10934.0, 11016.283941543774, 11487.942560287145, 11545.0, 10428.634997775041, 10473.133203197314, 10475.16198704117, 10624.84062739044, 10858.0, 9821.214302855611, 9869.802603947737, 10368.53341599645, 10601.628942986958, 10722.981316774894, 8543.487390756574, 8703.56482175876, 8997.83028206329, 9534.141927226583, 9599.42403455795], "unit": "score", "name": "yui.html", "value": 6240.84941318955}], "name": "dromaeo_css", "value": 6930.839807989611}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 104.0, 112.0, 109.0, 110.0, 102.0, 111.0, 110.0, 116.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 150.0, 169.0, 124.0, 149.0, 150.0, 124.0, 159.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 159.0, 160.0, 160.0, 161.0, 160.0, 162.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 86.0, 97.0, 71.0, 71.0, 71.0, 92.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 93.0, 93.0, 94.0, 138.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 55.0, 56.0, 57.0, 59.0, 64.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 77.0, 70.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 83.0, 94.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 122.0, 117.0, 113.0, 112.0, 114.0, 122.0, 116.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 148.0, 151.0, 151.0, 141.0, 148.0, 149.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 65.0, 65.0, 65.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1490.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.37851490149856], "unit": "score", "name": "Richards", "value": 209.65857799999998}, {"lowerIsBetter": false, "replicates": [188.46588767433096], "unit": "score", "name": "DeltaBlue", "value": 350.8221079999999}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1089.3246187363834], "unit": "score", "name": "RayTrace", "value": 679.3099019999999}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [692.5722145804676], "unit": "score", "name": "Splay", "value": 117.66426415094338}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20731.09073512679}]} 05:06:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20731.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1490.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6930.84"}}} 05:06:53 INFO - Return code: 0 05:06:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:06:54 INFO - # TBPL SUCCESS # 05:06:54 INFO - Running post-action listener: _resource_record_post_action 05:06:54 INFO - Running post-run listener: _resource_record_post_run 05:06:55 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547205120; Read time: 12; Write time: 488460 05:06:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 166567936; Read time: 0; Write time: 229744 05:06:55 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312303616; Read time: 12; Write time: 216884 05:06:55 INFO - Running post-run listener: _upload_blobber_files 05:06:55 INFO - Blob upload gear active. 05:06:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:06:55 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 05:06:55 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'] 05:06:55 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 05:06:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:56 INFO - (blobuploader) - INFO - Done attempting. 05:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:57 INFO - (blobuploader) - INFO - Done attempting. 05:06:57 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:57 INFO - Return code: 0 05:06:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:06:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e1fe2419fd32a37f051baa6ebc2ed57b57e49ff186b66c8e52d7d17720f3e7a22e1a82edd0f5b5d1b4991d36bec64f6a6ae6fde65c72ff36bf9786c7f68b9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efa97188743cacd723d2c0d94b81f5623f2a0831490c84ac9a68f7a479912c691e0aaf0bfa44ce4d1de706a982f66c95d2e2b23cfecf1c9ece1b92b9b651dce7"} 05:06:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:06:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:06:57 INFO - Contents: 05:06:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e1fe2419fd32a37f051baa6ebc2ed57b57e49ff186b66c8e52d7d17720f3e7a22e1a82edd0f5b5d1b4991d36bec64f6a6ae6fde65c72ff36bf9786c7f68b9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efa97188743cacd723d2c0d94b81f5623f2a0831490c84ac9a68f7a479912c691e0aaf0bfa44ce4d1de706a982f66c95d2e2b23cfecf1c9ece1b92b9b651dce7"} 05:06:57 INFO - Copying logs to upload dir... 05:06:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1286.384895 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-22 05:06:56.623295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:56.626727) ========= 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=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 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/7e1fe2419fd32a37f051baa6ebc2ed57b57e49ff186b66c8e52d7d17720f3e7a22e1a82edd0f5b5d1b4991d36bec64f6a6ae6fde65c72ff36bf9786c7f68b9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efa97188743cacd723d2c0d94b81f5623f2a0831490c84ac9a68f7a479912c691e0aaf0bfa44ce4d1de706a982f66c95d2e2b23cfecf1c9ece1b92b9b651dce7"} build_url:https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/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/7e1fe2419fd32a37f051baa6ebc2ed57b57e49ff186b66c8e52d7d17720f3e7a22e1a82edd0f5b5d1b4991d36bec64f6a6ae6fde65c72ff36bf9786c7f68b9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efa97188743cacd723d2c0d94b81f5623f2a0831490c84ac9a68f7a479912c691e0aaf0bfa44ce4d1de706a982f66c95d2e2b23cfecf1c9ece1b92b9b651dce7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:56.651454) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:56.651773) ========= 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=820bb6602ddf640013a48df2000001a9-1450787671.189032-1624620999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:56.734337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 05:06:56.734655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 05:06:56.734964) ========= ========= Total master_lag: 0.24 =========