builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1452689844.57 results: success (0) buildid: 20160113023003 builduid: c5737735f0f84235b2424b8d8e3a8169 revision: 7737b44d63eea024ded2751ae8d92cb72ac741f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.574892) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.575327) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.575607) ========= 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=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006364 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.605987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.606271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.623642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.623905) ========= 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=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.672615) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.672878) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.673234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.673501) ========= 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=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 04:57:24-- 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% 34.9M=0s 2016-01-13 04:57:24 (34.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096461 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.782312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.782627) ========= 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=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022432 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:24.833927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:57:24.834250) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7737b44d63eea024ded2751ae8d92cb72ac741f9 --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 7737b44d63eea024ded2751ae8d92cb72ac741f9 --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=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 04:57:24,895 truncating revision to first 12 chars 2016-01-13 04:57:24,895 Setting DEBUG logging. 2016-01-13 04:57:24,895 attempt 1/10 2016-01-13 04:57:24,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7737b44d63ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 04:57:26,267 unpacking tar archive at: fx-team-7737b44d63ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.679093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:57:26.526844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:26.527250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:26.536628) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:26.537028) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:57:26.537543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-13 04:57:26.537895) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:26 INFO - MultiFileLogger online at 20160113 04:57:26 in /builds/slave/test-pgo 04:57:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:57:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:57:26 INFO - {'append_to_log': False, 04:57:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:57:26 INFO - 'blob_upload_branch': 'Fx-Team', 04:57:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:57:26 INFO - 'branch': 'Fx-Team', 04:57:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:26 INFO - 'config_files': ('talos/linux_config.py',), 04:57:26 INFO - 'default_actions': ('clobber', 04:57:26 INFO - 'read-buildbot-config', 04:57:26 INFO - 'download-and-extract', 04:57:26 INFO - 'populate-webroot', 04:57:26 INFO - 'create-virtualenv', 04:57:26 INFO - 'install', 04:57:26 INFO - 'run-tests'), 04:57:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:26 INFO - 'download_minidump_stackwalk': True, 04:57:26 INFO - 'download_symbols': 'ondemand', 04:57:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:26 INFO - 'installer_path': 'installer.exe', 04:57:26 INFO - 'log_level': 'info', 04:57:26 INFO - 'log_name': 'talos', 04:57:26 INFO - 'log_to_console': True, 04:57:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:26 INFO - 'opt_config_files': (), 04:57:26 INFO - 'pip_index': False, 04:57:26 INFO - 'sps_profile': False, 04:57:26 INFO - 'sps_profile_interval': 0, 04:57:26 INFO - 'suite': 'dromaeojs', 04:57:26 INFO - 'system_bits': '32', 04:57:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:26 INFO - 'title': 'talos-linux64-ix-018', 04:57:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:26 INFO - 'use_talos_json': True, 04:57:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:57:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:26 INFO - 'work_dir': 'build'} 04:57:26 INFO - ##### 04:57:26 INFO - ##### Running clobber step. 04:57:26 INFO - ##### 04:57:26 INFO - Running pre-action listener: _resource_record_pre_action 04:57:26 INFO - Running main action method: clobber 04:57:26 INFO - rmtree: /builds/slave/test-pgo/build 04:57:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:57:27 INFO - Running post-action listener: _resource_record_post_action 04:57:27 INFO - ##### 04:57:27 INFO - ##### Running read-buildbot-config step. 04:57:27 INFO - ##### 04:57:27 INFO - Running pre-action listener: _resource_record_pre_action 04:57:27 INFO - Running main action method: read_buildbot_config 04:57:27 INFO - Using buildbot properties: 04:57:27 INFO - { 04:57:27 INFO - "project": "", 04:57:27 INFO - "product": "firefox", 04:57:27 INFO - "script_repo_revision": "production", 04:57:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:57:27 INFO - "repository": "", 04:57:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:57:27 INFO - "buildid": "20160113023003", 04:57:27 INFO - "pgo_build": "True", 04:57:27 INFO - "basedir": "/builds/slave/test-pgo", 04:57:27 INFO - "buildnumber": 894, 04:57:27 INFO - "slavename": "talos-linux64-ix-018", 04:57:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:57:27 INFO - "platform": "ubuntu64_hw", 04:57:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:57:27 INFO - "branch": "fx-team", 04:57:27 INFO - "repo_path": "integration/fx-team", 04:57:27 INFO - "revision": "7737b44d63eea024ded2751ae8d92cb72ac741f9", 04:57:27 INFO - "stage_platform": "linux64-pgo", 04:57:27 INFO - "builduid": "c5737735f0f84235b2424b8d8e3a8169", 04:57:27 INFO - "slavebuilddir": "test" 04:57:27 INFO - } 04:57:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:57:27 INFO - Running post-action listener: _resource_record_post_action 04:57:27 INFO - ##### 04:57:27 INFO - ##### Running download-and-extract step. 04:57:27 INFO - ##### 04:57:27 INFO - Running pre-action listener: _resource_record_pre_action 04:57:27 INFO - Running main action method: download_and_extract 04:57:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:27 INFO - https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/test_packages.json 04:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/test_packages.json 04:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:57:27 INFO - Downloaded 1302 bytes. 04:57:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:57:27 INFO - Using the following test package requirements: 04:57:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:57:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:27 INFO - u'jsshell-linux-x86_64.zip'], 04:57:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:57:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:57:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:57:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:57:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:57:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:27 INFO - https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:29 INFO - Downloaded 24025932 bytes. 04:57:29 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:57:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:29 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:57:30 INFO - Return code: 0 04:57:30 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:57:30 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:57:30 INFO - https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:33 INFO - Downloaded 24025932 bytes. 04:57:33 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:57:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:33 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:57:35 INFO - Return code: 0 04:57:35 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:57:35 INFO - https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:37 INFO - Downloaded 11132285 bytes. 04:57:37 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:57:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:37 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:57:37 INFO - Return code: 0 04:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:37 INFO - https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Les615SISmuxnW1ZiyuUWg/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:57:40 INFO - Downloaded 55744611 bytes. 04:57:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:40 INFO - mkdir: /builds/slave/test-pgo/properties 04:57:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:57:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:57:40 INFO - Contents: 04:57:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:40 INFO - Running post-action listener: _resource_record_post_action 04:57:40 INFO - Running post-action listener: set_extra_try_arguments 04:57:40 INFO - ##### 04:57:40 INFO - ##### Running populate-webroot step. 04:57:40 INFO - ##### 04:57:40 INFO - Running pre-action listener: _resource_record_pre_action 04:57:40 INFO - Running main action method: populate_webroot 04:57:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:40 INFO - '--tppagecycles', 04:57:40 INFO - '7'], 04:57:40 INFO - 'tests': ['tsvgm']}}, 04:57:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:57:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'tests': ['damp', 'tps']}, 04:57:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['damp', 'tps']}, 04:57:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:57:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:40 INFO - 'other': {'tests': ['a11yr', 04:57:40 INFO - 'ts_paint', 04:57:40 INFO - 'tpaint', 04:57:40 INFO - 'sessionrestore', 04:57:40 INFO - 'sessionrestore_no_auto_restore']}, 04:57:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['a11yr', 04:57:40 INFO - 'ts_paint', 04:57:40 INFO - 'tpaint', 04:57:40 INFO - 'sessionrestore', 04:57:40 INFO - 'sessionrestore_no_auto_restore']}, 04:57:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['a11yr', 04:57:40 INFO - 'ts_paint', 04:57:40 INFO - 'tpaint', 04:57:40 INFO - 'sessionrestore', 04:57:40 INFO - 'sessionrestore_no_auto_restore']}, 04:57:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['a11yr', 04:57:40 INFO - 'ts_paint', 04:57:40 INFO - 'tpaint', 04:57:40 INFO - 'sessionrestore', 04:57:40 INFO - 'sessionrestore_no_auto_restore']}, 04:57:40 INFO - 'other_l64': {'tests': ['a11yr', 04:57:40 INFO - 'ts_paint', 04:57:40 INFO - 'tpaint', 04:57:40 INFO - 'sessionrestore', 04:57:40 INFO - 'sessionrestore_no_auto_restore']}, 04:57:40 INFO - 'other_nol64': {'tests': ['a11yr', 04:57:40 INFO - 'ts_paint', 04:57:40 INFO - 'tpaint', 04:57:40 INFO - 'sessionrestore', 04:57:40 INFO - 'sessionrestore_no_auto_restore']}, 04:57:40 INFO - 'svgr': {'tests': ['tsvgx', 04:57:40 INFO - 'tsvgr_opacity', 04:57:40 INFO - 'tart', 04:57:40 INFO - 'tscrollx', 04:57:40 INFO - 'cart']}, 04:57:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['tsvgx', 04:57:40 INFO - 'tsvgr_opacity', 04:57:40 INFO - 'tart', 04:57:40 INFO - 'tscrollx', 04:57:40 INFO - 'cart']}, 04:57:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'tests': ['tp5o']}, 04:57:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'talos_options': ['--e10s'], 04:57:40 INFO - 'tests': ['tp5o']}, 04:57:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'talos_options': ['--xperf_path', 04:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:40 INFO - 'tests': ['tp5n']}, 04:57:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:40 INFO - 'talos_options': ['--e10s', 04:57:40 INFO - '--xperf_path', 04:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:40 INFO - 'tests': ['tp5n']}}, 04:57:40 INFO - 'talos.zip': {'path': '', 04:57:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:40 INFO - Running post-action listener: _resource_record_post_action 04:57:40 INFO - ##### 04:57:40 INFO - ##### Running create-virtualenv step. 04:57:40 INFO - ##### 04:57:40 INFO - Running pre-action listener: _resource_record_pre_action 04:57:40 INFO - Running main action method: create_virtualenv 04:57:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:57:40 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:57:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:57:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:41 INFO - Using real prefix '/usr' 04:57:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:57:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:43 INFO - Installing pip.................done. 04:57:43 INFO - Return code: 0 04:57:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:57:43 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:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 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:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:57:43 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:57:43 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:57:43 INFO - Using env: {'DISPLAY': ':0', 04:57:43 INFO - 'HOME': '/home/cltbld', 04:57:43 INFO - 'LANG': 'en_US.UTF-8', 04:57:43 INFO - 'LANGUAGE': 'en_US:en', 04:57:43 INFO - 'LOGNAME': 'cltbld', 04:57:43 INFO - 'MAIL': '/var/mail/cltbld', 04:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:43 INFO - 'MOZ_NO_REMOTE': '1', 04:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:43 INFO - 'NO_EM_RESTART': '1', 04:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:43 INFO - 'SHELL': '/bin/bash', 04:57:43 INFO - 'SHLVL': '1', 04:57:43 INFO - 'TERM': 'linux', 04:57:43 INFO - 'TMOUT': '86400', 04:57:43 INFO - 'USER': 'cltbld', 04:57:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:43 INFO - '_': '/tools/buildbot/bin/python'} 04:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:43 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:57:43 INFO - Cleaning up... 04:57:43 INFO - Return code: 0 04:57:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:57:43 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:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 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:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:57:43 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:57:43 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:57:43 INFO - Using env: {'DISPLAY': ':0', 04:57:43 INFO - 'HOME': '/home/cltbld', 04:57:43 INFO - 'LANG': 'en_US.UTF-8', 04:57:43 INFO - 'LANGUAGE': 'en_US:en', 04:57:43 INFO - 'LOGNAME': 'cltbld', 04:57:43 INFO - 'MAIL': '/var/mail/cltbld', 04:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:43 INFO - 'MOZ_NO_REMOTE': '1', 04:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:43 INFO - 'NO_EM_RESTART': '1', 04:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:43 INFO - 'SHELL': '/bin/bash', 04:57:43 INFO - 'SHLVL': '1', 04:57:43 INFO - 'TERM': 'linux', 04:57:43 INFO - 'TMOUT': '86400', 04:57:43 INFO - 'USER': 'cltbld', 04:57:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:43 INFO - '_': '/tools/buildbot/bin/python'} 04:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:43 INFO - Downloading/unpacking psutil>=0.7.1 04:57:43 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:57:43 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:57:43 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:57:43 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:57:43 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:57:43 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:57:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:57:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:57:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:45 INFO - Installing collected packages: psutil 04:57:45 INFO - Running setup.py install for psutil 04:57:45 INFO - building 'psutil._psutil_linux' extension 04:57:45 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:57:45 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:57:45 INFO - building 'psutil._psutil_posix' extension 04:57:45 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:57:46 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:57:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:46 INFO - Successfully installed psutil 04:57:46 INFO - Cleaning up... 04:57:46 INFO - Return code: 0 04:57:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:57:47 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:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:47 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:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:47 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:57:47 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:57:47 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:57:47 INFO - Using env: {'DISPLAY': ':0', 04:57:47 INFO - 'HOME': '/home/cltbld', 04:57:47 INFO - 'LANG': 'en_US.UTF-8', 04:57:47 INFO - 'LANGUAGE': 'en_US:en', 04:57:47 INFO - 'LOGNAME': 'cltbld', 04:57:47 INFO - 'MAIL': '/var/mail/cltbld', 04:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:47 INFO - 'MOZ_NO_REMOTE': '1', 04:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:47 INFO - 'NO_EM_RESTART': '1', 04:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:47 INFO - 'SHELL': '/bin/bash', 04:57:47 INFO - 'SHLVL': '1', 04:57:47 INFO - 'TERM': 'linux', 04:57:47 INFO - 'TMOUT': '86400', 04:57:47 INFO - 'USER': 'cltbld', 04:57:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:47 INFO - '_': '/tools/buildbot/bin/python'} 04:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:57:47 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:57:47 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:57:47 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:57:47 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:57:47 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:57:47 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:57:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:57:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:57:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:49 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:57:49 INFO - Installing collected packages: mozsystemmonitor 04:57:49 INFO - Running setup.py install for mozsystemmonitor 04:57:49 INFO - Successfully installed mozsystemmonitor 04:57:49 INFO - Cleaning up... 04:57:49 INFO - Return code: 0 04:57:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:57:49 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:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 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:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:57:49 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:57:49 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:57:49 INFO - Using env: {'DISPLAY': ':0', 04:57:49 INFO - 'HOME': '/home/cltbld', 04:57:49 INFO - 'LANG': 'en_US.UTF-8', 04:57:49 INFO - 'LANGUAGE': 'en_US:en', 04:57:49 INFO - 'LOGNAME': 'cltbld', 04:57:49 INFO - 'MAIL': '/var/mail/cltbld', 04:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:49 INFO - 'MOZ_NO_REMOTE': '1', 04:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:49 INFO - 'NO_EM_RESTART': '1', 04:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:49 INFO - 'SHELL': '/bin/bash', 04:57:49 INFO - 'SHLVL': '1', 04:57:49 INFO - 'TERM': 'linux', 04:57:49 INFO - 'TMOUT': '86400', 04:57:49 INFO - 'USER': 'cltbld', 04:57:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:49 INFO - '_': '/tools/buildbot/bin/python'} 04:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:49 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:57:49 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:57:49 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:57:49 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:57:49 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:57:49 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:57:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:57:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:51 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:57:51 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:57:51 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:57:51 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:57:51 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:57:51 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:57:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:57:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:57:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:52 INFO - Downloading docopt-0.6.1.tar.gz 04:57:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:57:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:52 INFO - Running setup.py install for blobuploader 04:57:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:57:52 INFO - Running setup.py install for requests 04:57:52 INFO - Running setup.py install for docopt 04:57:52 INFO - Successfully installed blobuploader requests docopt 04:57:52 INFO - Cleaning up... 04:57:52 INFO - Return code: 0 04:57:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:52 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:57:52 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:57:52 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:57:52 INFO - Using env: {'DISPLAY': ':0', 04:57:52 INFO - 'HOME': '/home/cltbld', 04:57:52 INFO - 'LANG': 'en_US.UTF-8', 04:57:52 INFO - 'LANGUAGE': 'en_US:en', 04:57:52 INFO - 'LOGNAME': 'cltbld', 04:57:52 INFO - 'MAIL': '/var/mail/cltbld', 04:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:52 INFO - 'MOZ_NO_REMOTE': '1', 04:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:52 INFO - 'NO_EM_RESTART': '1', 04:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:52 INFO - 'SHELL': '/bin/bash', 04:57:52 INFO - 'SHLVL': '1', 04:57:52 INFO - 'TERM': 'linux', 04:57:52 INFO - 'TMOUT': '86400', 04:57:52 INFO - 'USER': 'cltbld', 04:57:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:52 INFO - '_': '/tools/buildbot/bin/python'} 04:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:53 INFO - Running setup.py (path:/tmp/pip-TyFN8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:53 INFO - Running setup.py (path:/tmp/pip-tsxJQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:53 INFO - Running setup.py (path:/tmp/pip-0DrONe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:53 INFO - Running setup.py (path:/tmp/pip-ka4kf8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:53 INFO - Running setup.py (path:/tmp/pip-hzMrgA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:53 INFO - Running setup.py (path:/tmp/pip-ooRXjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:53 INFO - Running setup.py (path:/tmp/pip-TZoGOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:53 INFO - Running setup.py (path:/tmp/pip-v_TCWZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:53 INFO - Running setup.py (path:/tmp/pip-brYGL_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:53 INFO - Running setup.py (path:/tmp/pip-ruYr9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:53 INFO - Running setup.py (path:/tmp/pip-0h3mQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:53 INFO - Running setup.py (path:/tmp/pip-VbQsOb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:54 INFO - Running setup.py (path:/tmp/pip-RivVcE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:54 INFO - Running setup.py (path:/tmp/pip-cazi12-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:54 INFO - Running setup.py (path:/tmp/pip-i2J1Y9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:54 INFO - Running setup.py (path:/tmp/pip-7anyee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:54 INFO - Running setup.py (path:/tmp/pip-MC1WuU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:54 INFO - Running setup.py install for manifestparser 04:57:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:57:54 INFO - Running setup.py install for mozcrash 04:57:54 INFO - Running setup.py install for mozdebug 04:57:54 INFO - Running setup.py install for mozdevice 04:57:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:57:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:57:54 INFO - Running setup.py install for mozfile 04:57:54 INFO - Running setup.py install for mozhttpd 04:57:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Running setup.py install for mozinfo 04:57:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Running setup.py install for mozInstall 04:57:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Running setup.py install for mozleak 04:57:55 INFO - Running setup.py install for mozlog 04:57:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Running setup.py install for moznetwork 04:57:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Running setup.py install for mozprocess 04:57:55 INFO - Running setup.py install for mozprofile 04:57:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Running setup.py install for mozrunner 04:57:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:57:55 INFO - Running setup.py install for mozscreenshot 04:57:56 INFO - Running setup.py install for moztest 04:57:56 INFO - Running setup.py install for mozversion 04:57:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:57:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:56 INFO - Cleaning up... 04:57:56 INFO - Return code: 0 04:57:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57: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:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:57:56 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:57:56 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:57:56 INFO - Using env: {'DISPLAY': ':0', 04:57:56 INFO - 'HOME': '/home/cltbld', 04:57:56 INFO - 'LANG': 'en_US.UTF-8', 04:57:56 INFO - 'LANGUAGE': 'en_US:en', 04:57:56 INFO - 'LOGNAME': 'cltbld', 04:57:56 INFO - 'MAIL': '/var/mail/cltbld', 04:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:56 INFO - 'MOZ_NO_REMOTE': '1', 04:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:56 INFO - 'NO_EM_RESTART': '1', 04:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:56 INFO - 'SHELL': '/bin/bash', 04:57:56 INFO - 'SHLVL': '1', 04:57:56 INFO - 'TERM': 'linux', 04:57:56 INFO - 'TMOUT': '86400', 04:57:56 INFO - 'USER': 'cltbld', 04:57:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:56 INFO - '_': '/tools/buildbot/bin/python'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:56 INFO - Running setup.py (path:/tmp/pip-T1dZOW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:56 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:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:56 INFO - Running setup.py (path:/tmp/pip-bZVpAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:56 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:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:56 INFO - Running setup.py (path:/tmp/pip-2QbKnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:56 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:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:56 INFO - Running setup.py (path:/tmp/pip-zu48E1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:56 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:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:56 INFO - Running setup.py (path:/tmp/pip-FrUSRx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:56 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:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:56 INFO - Running setup.py (path:/tmp/pip-J8KH33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:56 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:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:56 INFO - Running setup.py (path:/tmp/pip-ItDaQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:56 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:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:56 INFO - Running setup.py (path:/tmp/pip-7Pz5pX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:57 INFO - Running setup.py (path:/tmp/pip-3fwJgL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:57 INFO - Running setup.py (path:/tmp/pip-vdclES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:57 INFO - Running setup.py (path:/tmp/pip-8v9LZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:57 INFO - Running setup.py (path:/tmp/pip-EjwOzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:57 INFO - Running setup.py (path:/tmp/pip-lqavvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:57 INFO - Running setup.py (path:/tmp/pip-4U_5zl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:57 INFO - Running setup.py (path:/tmp/pip-lXAvmT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:57 INFO - Running setup.py (path:/tmp/pip-N6oPI4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:57 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:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:57 INFO - Running setup.py (path:/tmp/pip-IYIwAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:57 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:57:57 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:57:57 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:57:57 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:57:57 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:57:57 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:57:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - Downloading blessings-1.5.1.tar.gz 04:57:59 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:57:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:59 INFO - Installing collected packages: blessings 04:57:59 INFO - Running setup.py install for blessings 04:57:59 INFO - Successfully installed blessings 04:57:59 INFO - Cleaning up... 04:57:59 INFO - Return code: 0 04:57:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:57:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:57:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:57:59 INFO - Reading from file tmpfile_stdout 04:57:59 INFO - Current package versions: 04:57:59 INFO - argparse == 1.2.1 04:57:59 INFO - blessings == 1.5.1 04:57:59 INFO - blobuploader == 1.2.4 04:57:59 INFO - docopt == 0.6.1 04:57:59 INFO - manifestparser == 1.1 04:57:59 INFO - mozInstall == 1.12 04:57:59 INFO - mozcrash == 0.16 04:57:59 INFO - mozdebug == 0.1 04:57:59 INFO - mozdevice == 0.47 04:57:59 INFO - mozfile == 1.2 04:57:59 INFO - mozhttpd == 0.7 04:57:59 INFO - mozinfo == 0.9 04:57:59 INFO - mozleak == 0.1 04:57:59 INFO - mozlog == 3.1 04:57:59 INFO - moznetwork == 0.27 04:57:59 INFO - mozprocess == 0.22 04:57:59 INFO - mozprofile == 0.28 04:57:59 INFO - mozrunner == 6.11 04:57:59 INFO - mozscreenshot == 0.1 04:57:59 INFO - mozsystemmonitor == 0.0 04:57:59 INFO - moztest == 0.7 04:57:59 INFO - mozversion == 1.4 04:57:59 INFO - psutil == 3.1.1 04:57:59 INFO - requests == 1.2.3 04:57:59 INFO - wsgiref == 0.1.2 04:57:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:59 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:57:59 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:57:59 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:57:59 INFO - Using env: {'DISPLAY': ':0', 04:57:59 INFO - 'HOME': '/home/cltbld', 04:57:59 INFO - 'LANG': 'en_US.UTF-8', 04:57:59 INFO - 'LANGUAGE': 'en_US:en', 04:57:59 INFO - 'LOGNAME': 'cltbld', 04:57:59 INFO - 'MAIL': '/var/mail/cltbld', 04:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:59 INFO - 'MOZ_NO_REMOTE': '1', 04:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:59 INFO - 'NO_EM_RESTART': '1', 04:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:59 INFO - 'SHELL': '/bin/bash', 04:57:59 INFO - 'SHLVL': '1', 04:57:59 INFO - 'TERM': 'linux', 04:57:59 INFO - 'TMOUT': '86400', 04:57:59 INFO - 'USER': 'cltbld', 04:57:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:59 INFO - '_': '/tools/buildbot/bin/python'} 04:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 INFO - Cleaning up... 04:58:00 INFO - Return code: 0 04:58:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:58:00 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:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:58:00 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:58:00 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:58:00 INFO - Using env: {'DISPLAY': ':0', 04:58:00 INFO - 'HOME': '/home/cltbld', 04:58:00 INFO - 'LANG': 'en_US.UTF-8', 04:58:00 INFO - 'LANGUAGE': 'en_US:en', 04:58:00 INFO - 'LOGNAME': 'cltbld', 04:58:00 INFO - 'MAIL': '/var/mail/cltbld', 04:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:00 INFO - 'MOZ_NO_REMOTE': '1', 04:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:00 INFO - 'NO_EM_RESTART': '1', 04:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:00 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:00 INFO - 'SHELL': '/bin/bash', 04:58:00 INFO - 'SHLVL': '1', 04:58:00 INFO - 'TERM': 'linux', 04:58:00 INFO - 'TMOUT': '86400', 04:58:00 INFO - 'USER': 'cltbld', 04:58:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:00 INFO - '_': '/tools/buildbot/bin/python'} 04:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:00 INFO - Downloading/unpacking jsonschema 04:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:00 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:58:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:01 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:58:01 INFO - Downloading/unpacking functools32 (from jsonschema) 04:58:01 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:58:01 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:58:01 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:58:01 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:58:01 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:58:01 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:58:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:02 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:58:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:02 INFO - warning: no files found matching '*.txt' 04:58:02 INFO - no previously-included directories found matching 'build' 04:58:02 INFO - no previously-included directories found matching 'dist' 04:58:02 INFO - no previously-included directories found matching '.git*' 04:58:02 INFO - Installing collected packages: jsonschema, functools32 04:58:02 INFO - Running setup.py install for functools32 04:58:02 INFO - warning: no files found matching '*.txt' 04:58:02 INFO - no previously-included directories found matching 'build' 04:58:02 INFO - no previously-included directories found matching 'dist' 04:58:02 INFO - no previously-included directories found matching '.git*' 04:58:02 INFO - Successfully installed jsonschema functools32 04:58:02 INFO - Cleaning up... 04:58:02 INFO - Return code: 0 04:58:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c19290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe29630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', '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:58:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:58:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:58:02 INFO - Using env: {'DISPLAY': ':0', 04:58:02 INFO - 'HOME': '/home/cltbld', 04:58:02 INFO - 'LANG': 'en_US.UTF-8', 04:58:02 INFO - 'LANGUAGE': 'en_US:en', 04:58:02 INFO - 'LOGNAME': 'cltbld', 04:58:02 INFO - 'MAIL': '/var/mail/cltbld', 04:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:02 INFO - 'MOZ_NO_REMOTE': '1', 04:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:02 INFO - 'NO_EM_RESTART': '1', 04:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:02 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:02 INFO - 'SHELL': '/bin/bash', 04:58:02 INFO - 'SHLVL': '1', 04:58:02 INFO - 'TERM': 'linux', 04:58:02 INFO - 'TMOUT': '86400', 04:58:02 INFO - 'USER': 'cltbld', 04:58:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:02 INFO - '_': '/tools/buildbot/bin/python'} 04:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:02 INFO - Downloading/unpacking flake8 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:04 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:58:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:04 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:58:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 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:58:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:58:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:05 INFO - no previously-included directories found matching 'docs/_build' 04:58:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:58:05 INFO - Running setup.py install for pep8 04:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:05 INFO - no previously-included directories found matching 'docs/_build' 04:58:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:58:05 INFO - Cleaning up... 04:58:05 INFO - Return code: 0 04:58:05 INFO - Running post-action listener: _resource_record_post_action 04:58:05 INFO - Running post-action listener: _start_resource_monitoring 04:58:05 INFO - Starting resource monitoring. 04:58:05 INFO - ##### 04:58:05 INFO - ##### Running install step. 04:58:05 INFO - ##### 04:58:05 INFO - Running pre-action listener: _resource_record_pre_action 04:58:05 INFO - Running main action method: install 04:58:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:58:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:58:05 INFO - Reading from file tmpfile_stdout 04:58:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:58:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:58:05 INFO - Reading from file tmpfile_stdout 04:58:05 INFO - Output received: 04:58:05 INFO - Usage: mozinstall [options] installer 04:58:05 INFO - Options: 04:58:05 INFO - -h, --help show this help message and exit 04:58:05 INFO - -d DEST, --destination=DEST 04:58:05 INFO - Directory to install application into. [default: 04:58:05 INFO - "/builds/slave/test-pgo"] 04:58:05 INFO - --app=APP Application being installed. [default: firefox] 04:58:05 INFO - mkdir: /builds/slave/test-pgo/build/application 04:58:05 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:58:05 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:58:21 INFO - Reading from file tmpfile_stdout 04:58:21 INFO - Output received: 04:58:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:58:21 INFO - Running post-action listener: _resource_record_post_action 04:58:21 INFO - ##### 04:58:21 INFO - ##### Running run-tests step. 04:58:21 INFO - ##### 04:58:21 INFO - Running pre-action listener: _resource_record_pre_action 04:58:21 INFO - Running main action method: run_tests 04:58:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:58:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:58:21 INFO - Python 2.7.3 04:58:21 INFO - Return code: 0 04:58:21 INFO - grabbing minidump binary from tooltool 04:58: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:58:21 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 0xeba840>, '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 0xe276b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:58:21 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:58:21 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:58:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:21 INFO - Return code: 0 04:58:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:58:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:58:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:58:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:58:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:58:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:58:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:58:22 INFO - Return code: 0 04:58:22 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/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:58:22 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/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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:58:22 INFO - Using env: {'DISPLAY': ':0', 04:58:22 INFO - 'HOME': '/home/cltbld', 04:58:22 INFO - 'LANG': 'en_US.UTF-8', 04:58:22 INFO - 'LANGUAGE': 'en_US:en', 04:58:22 INFO - 'LOGNAME': 'cltbld', 04:58:22 INFO - 'MAIL': '/var/mail/cltbld', 04:58:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:58:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:22 INFO - 'MOZ_NO_REMOTE': '1', 04:58:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:22 INFO - 'NO_EM_RESTART': '1', 04:58:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:58:22 INFO - 'SHELL': '/bin/bash', 04:58:22 INFO - 'SHLVL': '1', 04:58:22 INFO - 'TERM': 'linux', 04:58:22 INFO - 'TMOUT': '86400', 04:58:22 INFO - 'USER': 'cltbld', 04:58:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103', 04:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:22 INFO - '_': '/tools/buildbot/bin/python'} 04:58:22 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/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:58:23 INFO - mozversion application_buildid: 20160113023003 04:58:23 INFO - mozversion application_changeset: 7737b44d63eea024ded2751ae8d92cb72ac741f9 04:58:23 INFO - mozversion application_display_name: Nightly 04:58:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:23 INFO - mozversion application_name: Firefox 04:58:23 INFO - mozversion application_remotingname: firefox 04:58:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:58:23 INFO - mozversion application_vendor: Mozilla 04:58:23 INFO - mozversion application_version: 46.0a1 04:58:23 INFO - mozversion platform_buildid: 20160113023003 04:58:23 INFO - mozversion platform_changeset: 7737b44d63eea024ded2751ae8d92cb72ac741f9 04:58:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:58:23 INFO - mozversion platform_version: 46.0a1 04:58:23 INFO - using testdate: 1452689903 04:58:23 INFO - actual date: 1452689903 04:58:23 INFO - starting webserver on 'localhost:47963' 04:58:23 INFO - SUITE-START | Running 3 tests 04:58:23 INFO - TEST-START | dromaeo_css 04:58:23 INFO - operating with platform_type : linux_ 04:58:23 INFO - Initialising browser for dromaeo_css test... 04:58:23 INFO - TEST-INFO | started process 4483 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOmzZpT/profile http://localhost:47963/getInfo.html) 04:58:27 INFO - PROCESS | 4483 | __metrics Screen width/height:1600/1200 04:58:27 INFO - PROCESS | 4483 | colorDepth:24 04:58:27 INFO - PROCESS | 4483 | Browser inner width/height: 1024/697 04:58:27 INFO - PROCESS | 4483 | __metrics 04:58:27 INFO - PROCESS | 4483 | 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:58:27 INFO - PROCESS | 4483 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:28 INFO - TEST-INFO | 4483: exit 0 04:58:28 INFO - Browser initialized. 04:58:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:28 INFO - TEST-INFO | started process 4578 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOmzZpT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:40 INFO - PROCESS | 4578 | RSS: Main: 148144128 04:58:40 INFO - PROCESS | 4578 | 04:59:30 INFO - PROCESS | 4578 | 1452689970965 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] 05:01:39 INFO - PROCESS | 4578 | Cycle 1(1): loaded http://localhost:47963/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47963/tests/dromaeo/cssquery-ext.html) 05:01:40 INFO - PROCESS | 4578 | RSS: Main: 292790272 05:01:40 INFO - PROCESS | 4578 | 05:04:42 INFO - PROCESS | 4578 | Cycle 1(1): loaded http://localhost:47963/tests/dromaeo/cssquery-ext.html (next: http://localhost:47963/tests/dromaeo/cssquery-jquery.html) 05:04:43 INFO - PROCESS | 4578 | RSS: Main: 235900928 05:04:43 INFO - PROCESS | 4578 | 05:07:45 INFO - PROCESS | 4578 | Cycle 1(1): loaded http://localhost:47963/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47963/tests/dromaeo/cssquery-mootools.html) 05:07:45 INFO - PROCESS | 4578 | RSS: Main: 241541120 05:07:45 INFO - PROCESS | 4578 | 05:10:47 INFO - PROCESS | 4578 | Cycle 1(1): loaded http://localhost:47963/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47963/tests/dromaeo/cssquery-prototype.html) 05:10:48 INFO - PROCESS | 4578 | RSS: Main: 212471808 05:10:48 INFO - PROCESS | 4578 | 05:13:50 INFO - PROCESS | 4578 | Cycle 1(1): loaded http://localhost:47963/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47963/tests/dromaeo/cssquery-yui.html) 05:13:51 INFO - PROCESS | 4578 | RSS: Main: 217665536 05:13:51 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | Cycle 1(1): loaded http://localhost:47963/tests/dromaeo/cssquery-yui.html (next: http://localhost:47963/tests/dromaeo/cssquery-dojo.html) 05:16:54 INFO - PROCESS | 4578 | RSS: Main: 270090240 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | __start_tp_report 05:16:54 INFO - PROCESS | 4578 | _x_x_mozilla_page_load 05:16:54 INFO - PROCESS | 4578 | _x_x_mozilla_page_load_details 05:16:54 INFO - PROCESS | 4578 | |i|pagename|runs| 05:16:54 INFO - PROCESS | 4578 | |0;dojo.html;3117.407692538419;3167.1132083016755;3188.1232661018216;3192.154079169019;3206.2625596112894;5084.694918304895;5160.045391602552;5182.041322355362;5209.55718763905;5231.947680523193;5070.594352451804;5092.108880945838;5229.686218826873;5295.655782374152;5351.785928562853;4717.528247175289;4729.668923175362;4751.524847515238;4791.952080479203;4820.349252850873;449.3409959656416;4679.953200468003;4750.168720473903;4778.928316075262;4806.158922188621;4765.976170119145;4777.426708794949;4777.593904518086;4778.187708089633;4779.761011949406;4777.163996300668;4777.235642297216;4787.80848766049;4792.712437253741;4862.5380588844;4744.1934871072;4752.762361881927;4762.023785124076;4789.928151077736;4798.376211092535;5067.037262920034;5073.568746656539;5073.746312684351;5082.288479612857;5103.336566246401;5489.58828087895;5531.419200983879;5541.362743284493;5576.442355764391;5606;5578.525825304854;5627.71861406928;5643.153526970947;5643.492085712305;5645.2096706461125;5148.382194136652;5223.37319521656;5275.973620131875;5276.841694749163;5284.445133260991;5747.48272655463;5753.798617048383;5771.365149833515;5784.71076446176;5825.883482330414;5507.228987941691;5512.33851937762;5512.5314348280845;5514.641548299428;5515.669059856422;5534.363548191929;5577.358603760538;5583.637063590853;5592.552595792326;5617.915731264035;5539.362973258047;5565.916511252334;5576.107822748422;5584.022796010682;5620.044592419298;5551.3893471718075;5600.551955843523;5604.3835178130375;5607.327120745536;5609.5792815539;4248.553901840324;4313.331433627793;4327.870163895088;4375.759333236639;4398.098389830077;3891.6108389161423;3895.844166233319;3901.4342920276968;3926.6466018058513;3937.2322397132284;5139.229115632685;5173.689578625294;5174.922376164361;5175.094358487249;5218.869528261824;5491.148871924858;5556.249906262684;5583;5588.413216612278;5593.412691667398;5106.234064890296;5123.795048198031;5128.615353848401;5170.1986192140275;5216;4791.257355109963;4794.832180873653;4795.20879054952;4821.4696383397795;4825.420949486084;5706.885862282814;5723.8569035774435;5764.279465066867;5810.12848072784;5913.999999999914;5590.273264475592;5596.580256480699;5604.215409842707;5605.943940560705;5608.943910560843;5781.710914454345;5790.10253410722;5802.883942321215;5806.912896306643;5807.506361959281;5440.319960004999;5504.889902202013;5523.917141242965;5525.171224316385;5599.020171469895;5544.528715059104;5546.889062218653;5547.2511210986;5547.556195504269;5558.555315574825;5350.946490535045;5394.406615272395;5414.83755487336;5438.15708565173;5444.6188766785945;5411.78352865881;5427.83716488506;5486.945130548644;5504.614676972574;5516.531094856982;5358.22305765654;5360.142377219626;5361.088614935392;5368.677879327252;5370.19447082925;5401.3248343957;5427.3215848019;5458.263134476795;5464.098423760035;5489;5290.7354632269;5375.81184658535;5400.702961337164;5445.83662490126;5453.10023846061 05:16:54 INFO - PROCESS | 4578 | |1;ext.html;518.9325387699598;528.5744975294888;534.7032397019655;549.5054450994107;551.1044552602023;28022.859885700567;28594.42811143776;28645.283867903287;28648.28379290519;28688.713112868863;28907.96466371032;29321.706782932164;29357.119286421443;36420.63579364205;37009.259814803685;8248.422610417274;8412.11672774359;8424.747257582283;8426;8428.072911979678;8257.752267431957;8413.242808147266;8414.36892233082;8415.28470080044;8419.873701894476;8358.164183581654;8379.790505237388;8457.281131103864;8472.19514146155;8490.66037358508;8319.916800832005;8353.540555269457;8392.622331995075;8420.747377578682;8437.957810210972;8172.305354044914;8339.666413343459;8340.541270230135;8343.249107580286;8350.039745429292;38512;38573.22853542913;38790.61209387898;38792.61207387918;38995.02512437184;3095.721385075354;3340.8830690925943;3540.7875527468177;3704;3760.9811950940343;28034.579481307796;28771.424571508454;28812.567811482844;28960.855195724096;28962;3594.370985077601;3630;3653.6163702811086;3684.1894783147663;3731;256809;261587;261862;262458;262953;50247;51225.48774512282;54416.45583544114;54833.45166548363;54840.90318193614;60761;61404.38595614076;61429.07856382158;61499;61503;14343.78484322736;14635.195064271567;14636.414543418145;14636.780448293284;14645.121292722471;10486.108680762221;10792.082672972729;11095.945885140898;11217.60738374153;11357.261777984404;18037.368692095715;18073.36743213981;18191;18201.908990454962;18233.452996409862;7090.6100164491445;7224.891626625605;7326.7069317226715;7328.303811137934;7434.479586429006;917.6833992272656;939.2251392600995;968.801395713877;1027.1885210683477;1027.3733022856052;25200.873995629903;25421.491570168862;25429.745702543107;25497.36256593563;25641.230763076765;981.082687687015;1001.4441984698417;1024.9590016399409;1059.4808543813476;1102.6251074634663;13433.932830335785;13492.190468571916;13522.729545409036;13650;13674.726505469835;326417;331831;333005;333012;333311;43304.78347608242;43400.3489947651;43795;43858.342124868155;43863.12273754507;1314.5464814638933;1326.7014921642747;1338.2104558310643;1351.668841133909;1355.0582345269943;24741.381465462786;25747;25763.871180643975;25771.484570308865;27496.450070998868;41127.38308925309;41380.379294310005;41412;41429.964250892765;41454;212483;214341;214599;214873;215030;26746.86626566855;29738.405231895675;30219;30445.086647400614;30699.2325191872;35213;37930.620693792705;38117.23765524729;38613;38661.420078699404;32203.999640211452;32700.182495437806;33133.83433082819;33505.49741753924;33883.49174762331;26815;32383.676163238066;32760.74110365637;32833.835830820695;34846.651533485354;32493.675063249066;32954.34091318112;33020.33959320848;33026;33029.834850825595;28488.287792805346;29993;30465.847670761505;30473.23816904595;30506.542401863546;23420.76579234186;23463.88268058649;23569;23807.285781426584;23821.523569528857 05:16:54 INFO - PROCESS | 4578 | |2;jquery.html;356.47776008148065;359.76794967246127;359.7949168973686;363.88719496955946;368.1514109976503;13519.594412167626;13769.299731048914;15826.841731582681;16517.83482165178;17857.642847143066;14440.783388249185;15208;15566.844331556682;15700.607484812885;15814.76277855833;5162.92255616166;5329.147336426173;5356.062689029423;5370.194470829368;5372.865678358034;3933.4886464759543;4089.652379547742;5174.249733788617;5254.57963362932;5686.772529098852;5821.3305469870875;5843.883122337572;5853.004989151855;5882.3529411764675;5893;5660.433956604348;5793.449622285876;5822.708864556797;5845.824625261228;5845.883082338372;4926.778294976734;5148.150555158394;5162.406323272834;5174.560162386202;5183.041137389595;19261;19521.219151233934;19533.511662208417;19623.116959736846;19652.41042768719;1968.8424926005885;2007.0867755171507;2072.896355182235;2073.1085633177727;2129.55279391328;8687.869681954775;8744.475331480067;9247.121523455327;9393.671221507215;9595.90404095964;1701.8213087625868;1747.3272789975824;1759.7353421818368;1833.587442825367;1834.8532117430573;53231.73384133093;54512.72743636296;54949.45050549483;55620.721896390256;56046.439535604935;9826.115649591571;10070.093691567794;10085.546150423103;10093.293469457214;10142.898571014342;13221.801672974912;13224.008199385085;13278.269695166666;13303.071054697015;13331.600051998455;7435.739749108755;7479.439042071866;7487.363574096263;7495.587742674205;7498.737544185928;7116.573005619679;7117.252688467636;7184.281571842774;7211.567305961659;7214.819629509304;4316.805743741539;4386.956130438654;4387.034852332482;4399.824007039747;4484.192845287879;1730.792304923392;1763.0920076160787;1793.9372121975669;1824.6441943821094;1856.1832793570786;871.324723339417;894.2041582991143;912.4707669551644;946.6402766948515;990.7671697151163;13700.862991370159;15372.545100194848;15957.521274361789;16082.43711470093;16138.273777680033;828.9171082891784;857.6697971281102;872.2672954718067;922.1930810540777;945.2815859946353;8844.601992910335;9036;9078.773030674154;9136.81726365469;9149.634014639472;502993;511806;514912;516308;516556;67566;68890;70595.64702176457;70832.29167708257;71486.64256678683;1078.2721662877527;1091.3779145886767;1096.9945150274357;1097.983530247047;1103.178132291432;14248.786268205778;14264.71470570562;15113.773293400387;15323.310451029507;15423.151726655142;33108.337833243684;33560.66439335673;33574.49638255477;33610;35102;41474.79262603668;41970.37044444275;42047.57952420437;42233.36649950314;44168.454104106204;2971.79197456176;2972.4500967321114;6863.828404289933;6983.127109111361;7080.504364694628;10642.787144257227;10864;11058.170637202082;11062.723431914266;11442.141839362248;9651.469169195761;9901.108900199017;9939.254555908192;10043.849342259726;10147.441890696082;9559.139677429064;9868.733354320202;10046.648367307109;10348.637797677045;10448.947755261479;7651.770446886602;9662.75843103928;9760.902390976;9924.950375248078;10131.949340253252;7014.228434872058;7094.503384763017;7132.714691412285;7270.091238595176;7273.3817625502425;8153.877691834508;9702.466364350028;9874.555644996137;9897.158741506764;10120.342177758423 05:16:54 INFO - PROCESS | 4578 | |3;mootools.html;1298.896088312935;1460.5764328344778;1466.8239811222654;1598.896071755336;1761.9030953297572;6648.401643852052;7209.711611535538;7372.041634587496;7372.152202496714;7374.410047196225;7212.170600380958;7387.852242955138;7393.778186654409;7395.926040739591;7398.297161769623;1993.2923812046731;2034.1151599054385;2204.515006698528;2222.411061068818;2258.1306197114145;2245.9887700561476;2266.9319920402413;2267.047839907243;2275.0558518215003;2277.544491101778;2176.4341271269427;2261.9095236190533;2263.5020295534955;2263.581237471065;2264.241479104502;2275.12407723027;2286.409121715904;2297.896594653236;2301.953960920789;2305.170138750049;2265.082641530183;2270.5685919675375;2270.8069814065825;2277.3054218463362;2323.047550504285;7497.737579184703;7547.28300811422;7550.282723141293;7554.584497852616;7559.924400756032;4505.662075344362;4603.033362993775;4616.607588354994;4620.376249206348;4633.62930965522;2926.6488021437563;3045.1321373408473;3111.066679996015;3146.197719581515;3157.9052628420955;1058.698270992771;1066.2323127348297;1069.743261617214;1105.4969988655223;1113.8106521891216;9815.901840981642;9971.351862128939;9978.451185184811;9979;9990;4246.278132717445;4296.162248361539;4307.5261721210645;4359.542248063971;4368.628666563378;8175.3459723222;8234.382421318425;8240.175982401712;8240.464369815943;8252.711155109542;4672.2991551266905;4680.157571637138;4699.859004229878;4711.1519926413575;4713;4372.060007098489;4383.452068491439;4385.057212699285;4386.4736231652405;4388.100439409914;3290.210349516099;3318.1372843060976;3387.7120444761977;3507.7719948203285;3576.5171701819922;1122.074288711816;1141.366541569437;1145.7078444996473;1149.9425028748528;1153.1236260441956;1240.4232032105115;1268.6384380451527;1285.5950375631646;1302.5180683147296;1303.3352989974992;6902.861942761117;6934.757283495154;6970.302969703091;7051.471139664545;7067.823304417328;1037.600523798328;1062.436908438529;1086.8206745886998;1116.916231282657;1137.4995002199005;5299.178627312773;5329.9467005330225;5356.705381203993;5362.839114826562;5371.4897084776885;8426.578671066422;8611.913880861237;8783.604737786814;8850.955745221232;8865.68970086044;8782.341324400568;8828.646854125764;8951.194392504705;8952;9038.683646072488;6938.444924406035;6984.3364880336285;7152.499325047197;7155.89266161008;7166.140063192451;6804.863902722017;6821.147356580427;6821.147356580427;6831.69257383409;6846.5892046477375;7875.094364148196;8098.109207987234;8102.1087680356295;8151.673933042612;8251.628676709443;8219.9589002057;8263.710770123016;8301.709440169565;8308.709195178382;8461.280791132822;6320.873582528232;6353.3011368748475;6416.358364163733;6430.678466076771;6436.935630643634;6452.322506136788;6581.111549940697;6850.21222559412;7018.192907815666;7024.016637670628;6583.539152259296;6693.598384096969;6696.330366963265;6774.898376524257;6806.387425131762;6479.5788273762055;6524.412802847766;6569.540132190892;6645.302243264581;6677.399034086956;6531.281559028408;6556.967215163893;6565.310642382672;6575.243846957661;6584.308647592125;5927.496162826208;6220.813375598739;6288.622682639057;6291.842703932255;6293.874122517615;6136.969315153396;6151.907721384094;6166.660833654013;6172.382761723792;6187.071939209155 05:16:54 INFO - PROCESS | 4578 | |4;prototype.html;334.74392090051106;342.16682378408575;345.5042014708894;345.7268757681432;352.1319946332289;5810.041343178375;5862.237909071825;5872.119182122673;5890.116482527628;5936;5576.5817563682685;5602.943970560304;5758.654480731159;5803.332616749075;5816.272965879265;4445.088756804847;4460.085682435093;4462.4645042594775;4472.859420847679;4473.507914129451;4270.103278311558;4471.910561788763;4472.284434490482;4474.149911516818;4479.238529450001;4328.458942632171;4338.544452832454;4391.0559229765595;4436.933445998313;4439.733615983036;4395.120975804852;4408.14041261954;4419.558044195554;4423.248047831844;4431.224535706255;3884.8057597120314;3886.24218277436;3886.689064874803;3888.0474283800368;3888.2612303662495;5524.751386187631;5605.215269862222;5611.102223644198;5617.831465056055;5619.719014049281;5183.844484665466;5191.662541934762;5196.934628401169;5198.636095473318;5200.453952334989;6161.845953851145;6164.445199931983;6164.784232551884;6167.044108163242;6167.506599472032;4329.653627709808;4334.934975975331;4344.761038142901;4353.477582690066;4358.760268185249;6302.149209856657;6434.260060093103;6444.484441244736;6446.484281257535;6455.838604034937;4436.624646359639;4436.778161091933;4440.555944405598;4443.533428989909;4448.266036104072;4471.23988921884;4488;4488.842890498817;4489.663275254369;4497.752623605733;5143.897122057613;5149;5154.072266991902;5155.716435596079;5164.8192313268855;6031.728572214261;6233.594816336924;6239.313675495692;6241.96879015602;6245.5628106032145;1544.691061787647;1545.4127431576153;1545.6754081642755;1546.7525195968592;1557.0424189123835;1055.1927775251938;1069.13934282903;1069.5988255385314;1070.641335152717;1080.9459527023616;5861.9706901465215;5878.911816322759;5886.941130588725;5899;5905.940940590625;6397.360263973658;6400.807975760735;6402.135711678957;6404.167458230493;6417.03744438338;5728.742206600713;5790.160426738184;5818.44724751148;5950.583459157818;5978.850528736816;3428.3486137633768;3442.4836274558515;3462.6364231755806;3463.688268055887;3468.5664291963503;6700.899486507707;6704.2625311215725;6706.530542861953;6706.698198580978;6709.496787740939;6353.396427339396;6501.739930402731;6532.118164047793;6551.574147680481;6559.540832141704;6718.193816741925;6718.7312507499155;6723.932760672428;6726.428253598499;6728.058071869942;6436.165692777536;6453.419192272718;6457.6771161442675;6461.2892581816905;6464.0627109069865;6172.475339596005;6296.590721603081;6365.077063825812;6373.330800266091;6379.808605741835;6688.264290927897;6701.229358623626;6705.731770729116;6715.664216789043;6718.126643536309;4386.0789234261165;4406.405135306821;4408.382826404242;4408.426904502394;4409.052053808318;6286.402791734778;6444.935550644621;6447.9355206447335;6449.774257900951;6452.193475815523;6277.372262773686;6284.685765711604;6286.434220919956;6289.465395441439;6290.811275661737;6243.625382477066;6243.906341404973;6246.937530624636;6247.875042499216;6250.968745156245;5968.641881487125;6111.113888486234;6162.722677479434;6170.321264660974;6189.071639254148;6319.652419116993;6326.082718005771;6331.810045698637;6336.303006669171;6340.71466784005;6174.567780255518;6175.320714721287;6180.6291622502795;6181.907271390843;6188.133661287513 05:16:54 INFO - PROCESS | 4578 | |5;yui.html;715.5420530860247;729.686234918985;807.216999510475;827.6647957577179;828.6726742936542;12632.62102136935;12732.80900786489;12740.299283539402;12786.616401507958;12803.551875684352;11795.410229488534;11937.701557461069;12079.818802717966;12765.234085954826;12878.162919410232;767.18678201107;778.7936196907796;779.3492433817769;779.4855395439012;779.7426849139798;654.1822721598003;659.0608383054152;764.9005629268215;774.380495603515;776.8174478997431;804.7545498622918;807.9515229086244;812.5327936436543;812.6627449608405;814.6619153051506;676.5061505101304;680.7515256931234;808.0505406147782;808.6926967752275;810.3800592546706;591.6420565557819;594.4917095883044;595.3718826637895;595.7974288741849;597.3309892919957;12696.301703406309;12727.109102362838;12753;12759.93620031894;12772.808407873888;12293.200941938745;12457.75084498314;12500.249985000839;12884.613461596167;12977;10136.239782016304;10221.846672299922;10309.381437113721;10734.677959661145;10951.890481095166;3545.3795585772646;3650.2881938022097;3685.5208822852856;3688.4651725499652;3700.777953322782;45984.310235346165;46237.30644040342;46375.5362446378;46665.76667116677;47848.521514784756;9081;9112.316576256808;9172.724818255463;9334.486603236752;9601.951990240004;16761.7485737714;16800.74798878018;16821.158942052847;16836.6632667346;16882.662346752997;7380.96309518449;7424.146223184295;7449.6275186241555;7516.098068231847;7621.733239336708;4120.649744771668;4166.520850102277;4177.394277829698;4223.13425747721;4247.129338485603;3086.8147911125407;3139.403513332505;3139.576157218792;3147.669494703069;3160.9051728448185;563.6730696196196;578.5400606517828;578.664374662703;581.8545363659085;586.0359708279856;514.4617593395794;541.0666600114849;555.5058680897112;601.6570554783731;622.7726879688881;8112.837743245102;8117.472364296302;8377.664893404195;8424.241818236389;8567.357448191411;530.8725905782584;563.605476166685;604.1662505742136;614.4408588184731;682.2631557917438;3702.5927148013698;3849.287881741887;3920.8235629396745;3928.738678596676;3967.900802479961;53981.46018539764;58562.12156817651;58679;58884.411155887894;58902;50241.24638130431;50488.74755626198;50558;50716.49283507118;51573.226401604006;45259.547404526194;45430.545694542634;45872;46047;46378.536214638094;7345.963270183614;7627.313541781266;7916.84166316659;7933.920660793549;7992.800179995546;33599.66400336063;33764.32471350608;34638;34784.304313913075;34845.47731784076;47123;48185;48312;48423.75788121037;49031.754841225564;9787.119159275699;10382.740431489274;10570;10705.143588512745;11251.887481125084;12028.819567706316;12198.14612977083;12202.694932626755;12229.205101668364;12359.073069519642;10425.687229383131;10456.26806123564;10591.20565957541;10910.072643825364;11108.38903860263;10804.297720648132;11074.667759967213;11130.721731956766;11422.200445968703;11532.019778318601;10933.398663073607;11247.550097996316;11361.091112710797;11556.306621602731;11668.94165529167;9450.338476306593;9492.477913714813;9581.377210481296;9698.27262955267;9960.800783984425;8825;8889.955550222208;9344.34589578723;9346.15884570392;9462.810743785223 05:16:54 INFO - PROCESS | 4578 | __end_tp_report 05:16:54 INFO - PROCESS | 4578 | __start_cc_report 05:16:54 INFO - PROCESS | 4578 | _x_x_mozilla_cycle_collect,962 05:16:54 INFO - PROCESS | 4578 | __end_cc_report 05:16:54 INFO - PROCESS | 4578 | __startTimestamp1452691014322__endTimestamp 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | ------- Summary: start ------- 05:16:54 INFO - PROCESS | 4578 | Number of tests: 6 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | [#0] dojo.html Cycles:165 Average:5162.62 Median:5375.81 stddev:669.98 (12.5%) stddev-sans-first:652.54 05:16:54 INFO - PROCESS | 4578 | Values: 3117.4 3167.1 3188.1 3192.2 3206.3 5084.7 5160.0 5182.0 5209.6 5231.9 5070.6 5092.1 5229.7 5295.7 5351.8 4717.5 4729.7 4751.5 4792.0 4820.3 449.3 4680.0 4750.2 4778.9 4806.2 4766.0 4777.4 4777.6 4778.2 4779.8 4777.2 4777.2 4787.8 4792.7 4862.5 4744.2 4752.8 4762.0 4789.9 4798.4 5067.0 5073.6 5073.7 5082.3 5103.3 5489.6 5531.4 5541.4 5576.4 5606.0 5578.5 5627.7 5643.2 5643.5 5645.2 5148.4 5223.4 5276.0 5276.8 5284.4 5747.5 5753.8 5771.4 5784.7 5825.9 5507.2 5512.3 5512.5 5514.6 5515.7 5534.4 5577.4 5583.6 5592.6 5617.9 5539.4 5565.9 5576.1 5584.0 5620.0 5551.4 5600.6 5604.4 5607.3 5609.6 4248.6 4313.3 4327.9 4375.8 4398.1 3891.6 3895.8 3901.4 3926.6 3937.2 5139.2 5173.7 5174.9 5175.1 5218.9 5491.1 5556.2 5583.0 5588.4 5593.4 5106.2 5123.8 5128.6 5170.2 5216.0 4791.3 4794.8 4795.2 4821.5 4825.4 5706.9 5723.9 5764.3 5810.1 5914.0 5590.3 5596.6 5604.2 5605.9 5608.9 5781.7 5790.1 5802.9 5806.9 5807.5 5440.3 5504.9 5523.9 5525.2 5599.0 5544.5 5546.9 5547.3 5547.6 5558.6 5350.9 5394.4 5414.8 5438.2 5444.6 5411.8 5427.8 5486.9 5504.6 5516.5 5358.2 5360.1 5361.1 5368.7 5370.2 5401.3 5427.3 5458.3 5464.1 5489.0 5290.7 5375.8 5400.7 5445.8 5453.1 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | [#1] ext.html Cycles:180 Average:42281.54 Median:33027.92 stddev:71614.94 (216.8%) stddev-sans-first:71747.19 05:16:54 INFO - PROCESS | 4578 | Values: 518.9 528.6 534.7 549.5 551.1 28022.9 28594.4 28645.3 28648.3 28688.7 28908.0 29321.7 29357.1 36420.6 37009.3 8248.4 8412.1 8424.7 8426.0 8428.1 8257.8 8413.2 8414.4 8415.3 8419.9 8358.2 8379.8 8457.3 8472.2 8490.7 8319.9 8353.5 8392.6 8420.7 8438.0 8172.3 8339.7 8340.5 8343.2 8350.0 38512.0 38573.2 38790.6 38792.6 38995.0 3095.7 3340.9 3540.8 3704.0 3761.0 28034.6 28771.4 28812.6 28960.9 28962.0 3594.4 3630.0 3653.6 3684.2 3731.0 256809.0 261587.0 261862.0 262458.0 262953.0 50247.0 51225.5 54416.5 54833.5 54840.9 60761.0 61404.4 61429.1 61499.0 61503.0 14343.8 14635.2 14636.4 14636.8 14645.1 10486.1 10792.1 11095.9 11217.6 11357.3 18037.4 18073.4 18191.0 18201.9 18233.5 7090.6 7224.9 7326.7 7328.3 7434.5 917.7 939.2 968.8 1027.2 1027.4 25200.9 25421.5 25429.7 25497.4 25641.2 981.1 1001.4 1025.0 1059.5 1102.6 13433.9 13492.2 13522.7 13650.0 13674.7 326417.0 331831.0 333005.0 333012.0 333311.0 43304.8 43400.3 43795.0 43858.3 43863.1 1314.5 1326.7 1338.2 1351.7 1355.1 24741.4 25747.0 25763.9 25771.5 27496.5 41127.4 41380.4 41412.0 41430.0 41454.0 212483.0 214341.0 214599.0 214873.0 215030.0 26746.9 29738.4 30219.0 30445.1 30699.2 35213.0 37930.6 38117.2 38613.0 38661.4 32204.0 32700.2 33133.8 33505.5 33883.5 26815.0 32383.7 32760.7 32833.8 34846.7 32493.7 32954.3 33020.3 33026.0 33029.8 28488.3 29993.0 30465.8 30473.2 30506.5 23420.8 23463.9 23569.0 23807.3 23821.5 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | [#2] jquery.html Cycles:180 Average:26471.49 Median:253959.89 stddev:83723.13 (33.0%) stddev-sans-first:83935.03 05:16:54 INFO - PROCESS | 4578 | Values: 356.5 359.8 359.8 363.9 368.2 13519.6 13769.3 15826.8 16517.8 17857.6 14440.8 15208.0 15566.8 15700.6 15814.8 5162.9 5329.1 5356.1 5370.2 5372.9 3933.5 4089.7 5174.2 5254.6 5686.8 5821.3 5843.9 5853.0 5882.4 5893.0 5660.4 5793.4 5822.7 5845.8 5845.9 4926.8 5148.2 5162.4 5174.6 5183.0 19261.0 19521.2 19533.5 19623.1 19652.4 1968.8 2007.1 2072.9 2073.1 2129.6 8687.9 8744.5 9247.1 9393.7 9595.9 1701.8 1747.3 1759.7 1833.6 1834.9 53231.7 54512.7 54949.5 55620.7 56046.4 9826.1 10070.1 10085.5 10093.3 10142.9 13221.8 13224.0 13278.3 13303.1 13331.6 7435.7 7479.4 7487.4 7495.6 7498.7 7116.6 7117.3 7184.3 7211.6 7214.8 4316.8 4387.0 4387.0 4399.8 4484.2 1730.8 1763.1 1793.9 1824.6 1856.2 871.3 894.2 912.5 946.6 990.8 13700.9 15372.5 15957.5 16082.4 16138.3 828.9 857.7 872.3 922.2 945.3 8844.6 9036.0 9078.8 9136.8 9149.6 502993.0 511806.0 514912.0 516308.0 516556.0 67566.0 68890.0 70595.6 70832.3 71486.6 1078.3 1091.4 1097.0 1098.0 1103.2 14248.8 14264.7 15113.8 15323.3 15423.2 33108.3 33560.7 33574.5 33610.0 35102.0 41474.8 41970.4 42047.6 42233.4 44168.5 2971.8 2972.5 6863.8 6983.1 7080.5 10642.8 10864.0 11058.2 11062.7 11442.1 9651.5 9901.1 9939.3 10043.8 10147.4 9559.1 9868.7 10046.6 10348.6 10448.9 7651.8 9662.8 9760.9 9925.0 10131.9 7014.2 7094.5 7132.7 7270.1 7273.4 8153.9 9702.5 9874.6 9897.2 10120.3 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | [#3] mootools.html Cycles:180 Average:5215.30 Median:6203.94 stddev:2611.83 (42.1%) stddev-sans-first:2602.56 05:16:54 INFO - PROCESS | 4578 | Values: 1298.9 1460.6 1466.8 1598.9 1761.9 6648.4 7209.7 7372.0 7372.2 7374.4 7212.2 7387.9 7393.8 7395.9 7398.3 1993.3 2034.1 2204.5 2222.4 2258.1 2246.0 2266.9 2267.0 2275.1 2277.5 2176.4 2261.9 2263.5 2263.6 2264.2 2275.1 2286.4 2297.9 2302.0 2305.2 2265.1 2270.6 2270.8 2277.3 2323.0 7497.7 7547.3 7550.3 7554.6 7559.9 4505.7 4603.0 4616.6 4620.4 4633.6 2926.6 3045.1 3111.1 3146.2 3157.9 1058.7 1066.2 1069.7 1105.5 1113.8 9815.9 9971.4 9978.5 9979.0 9990.0 4246.3 4296.2 4307.5 4359.5 4368.6 8175.3 8234.4 8240.2 8240.5 8252.7 4672.3 4680.2 4699.9 4711.2 4713.0 4372.1 4383.5 4385.1 4386.5 4388.1 3290.2 3318.1 3387.7 3507.8 3576.5 1122.1 1141.4 1145.7 1149.9 1153.1 1240.4 1268.6 1285.6 1302.5 1303.3 6902.9 6934.8 6970.3 7051.5 7067.8 1037.6 1062.4 1086.8 1116.9 1137.5 5299.2 5329.9 5356.7 5362.8 5371.5 8426.6 8611.9 8783.6 8851.0 8865.7 8782.3 8828.6 8951.2 8952.0 9038.7 6938.4 6984.3 7152.5 7155.9 7166.1 6804.9 6821.1 6821.1 6831.7 6846.6 7875.1 8098.1 8102.1 8151.7 8251.6 8220.0 8263.7 8301.7 8308.7 8461.3 6320.9 6353.3 6416.4 6430.7 6436.9 6452.3 6581.1 6850.2 7018.2 7024.0 6583.5 6693.6 6696.3 6774.9 6806.4 6479.6 6524.4 6569.5 6645.3 6677.4 6531.3 6557.0 6565.3 6575.2 6584.3 5927.5 6220.8 6288.6 6291.8 6293.9 6137.0 6151.9 6166.7 6172.4 6187.1 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | [#4] prototype.html Cycles:180 Average:5197.66 Median:5867.18 stddev:1572.46 (26.8%) stddev-sans-first:1533.92 05:16:54 INFO - PROCESS | 4578 | Values: 334.7 342.2 345.5 345.7 352.1 5810.0 5862.2 5872.1 5890.1 5936.0 5576.6 5602.9 5758.7 5803.3 5816.3 4445.1 4460.1 4462.5 4472.9 4473.5 4270.1 4471.9 4472.3 4474.1 4479.2 4328.5 4338.5 4391.1 4436.9 4439.7 4395.1 4408.1 4419.6 4423.2 4431.2 3884.8 3886.2 3886.7 3888.0 3888.3 5524.8 5605.2 5611.1 5617.8 5619.7 5183.8 5191.7 5196.9 5198.6 5200.5 6161.8 6164.4 6164.8 6167.0 6167.5 4329.7 4334.9 4344.8 4353.5 4358.8 6302.1 6434.3 6444.5 6446.5 6455.8 4436.6 4436.8 4440.6 4443.5 4448.3 4471.2 4488.0 4488.8 4489.7 4497.8 5143.9 5149.0 5154.1 5155.7 5164.8 6031.7 6233.6 6239.3 6242.0 6245.6 1544.7 1545.4 1545.7 1546.8 1557.0 1055.2 1069.1 1069.6 1070.6 1080.9 5862.0 5878.9 5886.9 5899.0 5905.9 6397.4 6400.8 6402.1 6404.2 6417.0 5728.7 5790.2 5818.4 5950.6 5978.9 3428.3 3442.5 3462.6 3463.7 3468.6 6700.9 6704.3 6706.5 6706.7 6709.5 6353.4 6501.7 6532.1 6551.6 6559.5 6718.2 6718.7 6723.9 6726.4 6728.1 6436.2 6453.4 6457.7 6461.3 6464.1 6172.5 6296.6 6365.1 6373.3 6379.8 6688.3 6701.2 6705.7 6715.7 6718.1 4386.1 4406.4 4408.4 4408.4 4409.1 6286.4 6444.9 6447.9 6449.8 6452.2 6277.4 6284.7 6286.4 6289.5 6290.8 6243.6 6243.9 6246.9 6247.9 6251.0 5968.6 6111.1 6162.7 6170.3 6189.1 6319.7 6326.1 6331.8 6336.3 6340.7 6174.6 6175.3 6180.6 6181.9 6188.1 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - PROCESS | 4578 | [#5] yui.html Cycles:180 Average:13606.27 Median:48248.50 stddev:16024.75 (33.2%) stddev-sans-first:16040.47 05:16:54 INFO - PROCESS | 4578 | Values: 715.5 729.7 807.2 827.7 828.7 12632.6 12732.8 12740.3 12786.6 12803.6 11795.4 11937.7 12079.8 12765.2 12878.2 767.2 778.8 779.3 779.5 779.7 654.2 659.1 764.9 774.4 776.8 804.8 808.0 812.5 812.7 814.7 676.5 680.8 808.1 808.7 810.4 591.6 594.5 595.4 595.8 597.3 12696.3 12727.1 12753.0 12759.9 12772.8 12293.2 12457.8 12500.2 12884.6 12977.0 10136.2 10221.8 10309.4 10734.7 10951.9 3545.4 3650.3 3685.5 3688.5 3700.8 45984.3 46237.3 46375.5 46665.8 47848.5 9081.0 9112.3 9172.7 9334.5 9602.0 16761.7 16800.7 16821.2 16836.7 16882.7 7381.0 7424.1 7449.6 7516.1 7621.7 4120.6 4166.5 4177.4 4223.1 4247.1 3086.8 3139.4 3139.6 3147.7 3160.9 563.7 578.5 578.7 581.9 586.0 514.5 541.1 555.5 601.7 622.8 8112.8 8117.5 8377.7 8424.2 8567.4 530.9 563.6 604.2 614.4 682.3 3702.6 3849.3 3920.8 3928.7 3967.9 53981.5 58562.1 58679.0 58884.4 58902.0 50241.2 50488.7 50558.0 50716.5 51573.2 45259.5 45430.5 45872.0 46047.0 46378.5 7346.0 7627.3 7916.8 7933.9 7992.8 33599.7 33764.3 34638.0 34784.3 34845.5 47123.0 48185.0 48312.0 48423.8 49031.8 9787.1 10382.7 10570.0 10705.1 11251.9 12028.8 12198.1 12202.7 12229.2 12359.1 10425.7 10456.3 10591.2 10910.1 11108.4 10804.3 11074.7 11130.7 11422.2 11532.0 10933.4 11247.6 11361.1 11556.3 11668.9 9450.3 9492.5 9581.4 9698.3 9960.8 8825.0 8890.0 9344.3 9346.2 9462.8 05:16:54 INFO - PROCESS | 4578 | -------- Summary: end -------- 05:16:54 INFO - PROCESS | 4578 | 05:16:54 INFO - TEST-INFO | 4578: exit 0 05:16:54 INFO - TEST-OK | dromaeo_css | took 1111915ms 05:16:54 INFO - TEST-START | kraken 05:16:54 INFO - operating with platform_type : linux_ 05:16:54 INFO - Initialising browser for kraken test... 05:16:55 INFO - TEST-INFO | started process 4758 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmhJ7Y1/profile http://localhost:47963/getInfo.html) 05:16:59 INFO - PROCESS | 4758 | __metrics Screen width/height:1600/1200 05:16:59 INFO - PROCESS | 4758 | colorDepth:24 05:16:59 INFO - PROCESS | 4758 | Browser inner width/height: 1024/697 05:16:59 INFO - PROCESS | 4758 | __metrics 05:16:59 INFO - PROCESS | 4758 | 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:16:59 INFO - PROCESS | 4758 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:00 INFO - TEST-INFO | 4758: exit 0 05:17:00 INFO - Browser initialized. 05:17:00 INFO - Running cycle 1/1 for kraken test... 05:17:00 INFO - TEST-INFO | started process 4839 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmhJ7Y1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:11 INFO - PROCESS | 4839 | RSS: Main: 148365312 05:17:11 INFO - PROCESS | 4839 | 05:17:14 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47963/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:14 INFO - PROCESS | 4839 | RSS: Main: 184639488 05:17:14 INFO - PROCESS | 4839 | 05:17:17 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47963/tests/kraken/driver.html?testName=audio-dft) 05:17:18 INFO - PROCESS | 4839 | RSS: Main: 173678592 05:17:18 INFO - PROCESS | 4839 | 05:17:21 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47963/tests/kraken/driver.html?testName=audio-fft) 05:17:21 INFO - PROCESS | 4839 | RSS: Main: 160145408 05:17:21 INFO - PROCESS | 4839 | 05:17:23 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47963/tests/kraken/driver.html?testName=audio-oscillator) 05:17:24 INFO - PROCESS | 4839 | RSS: Main: 162390016 05:17:24 INFO - PROCESS | 4839 | 05:17:26 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47963/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:26 INFO - PROCESS | 4839 | RSS: Main: 164270080 05:17:26 INFO - PROCESS | 4839 | 05:17:29 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47963/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:30 INFO - PROCESS | 4839 | RSS: Main: 163164160 05:17:30 INFO - PROCESS | 4839 | 05:17:33 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47963/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:34 INFO - PROCESS | 4839 | RSS: Main: 165658624 05:17:34 INFO - PROCESS | 4839 | 05:17:37 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47963/tests/kraken/driver.html?testName=json-parse-financial) 05:17:37 INFO - PROCESS | 4839 | RSS: Main: 164204544 05:17:37 INFO - PROCESS | 4839 | 05:17:39 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47963/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:39 INFO - PROCESS | 4839 | RSS: Main: 173686784 05:17:39 INFO - PROCESS | 4839 | 05:17:41 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:42 INFO - PROCESS | 4839 | RSS: Main: 172240896 05:17:42 INFO - PROCESS | 4839 | 05:17:44 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:44 INFO - PROCESS | 4839 | RSS: Main: 180551680 05:17:44 INFO - PROCESS | 4839 | 05:17:47 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:47 INFO - PROCESS | 4839 | RSS: Main: 189591552 05:17:47 INFO - PROCESS | 4839 | 05:17:50 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:50 INFO - PROCESS | 4839 | RSS: Main: 187977728 05:17:50 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | Cycle 1(1): loaded http://localhost:47963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47963/tests/kraken/driver.html?testName=ai-astar) 05:17:52 INFO - PROCESS | 4839 | RSS: Main: 246427648 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | __start_tp_report 05:17:52 INFO - PROCESS | 4839 | _x_x_mozilla_page_load 05:17:52 INFO - PROCESS | 4839 | _x_x_mozilla_page_load_details 05:17:52 INFO - PROCESS | 4839 | |i|pagename|runs| 05:17:52 INFO - PROCESS | 4839 | |0;ai-astar;108;110;103;109;109;109;100;110;110;109 05:17:52 INFO - PROCESS | 4839 | |1;audio-beat-detection;154;122;149;172;124;152;150;130;164;124 05:17:52 INFO - PROCESS | 4839 | |2;audio-dft;160;162;160;161;159;159;163;164;159;163 05:17:52 INFO - PROCESS | 4839 | |3;audio-fft;71;71;78;91;74;71;71;96;91;73 05:17:52 INFO - PROCESS | 4839 | |4;audio-oscillator;96;96;145;96;96;96;139;95;96;135 05:17:52 INFO - PROCESS | 4839 | |5;imaging-gaussian-blur;109;109;110;110;109;109;109;109;109;110 05:17:52 INFO - PROCESS | 4839 | |6;imaging-darkroom;146;145;146;146;145;144;146;148;146;144 05:17:52 INFO - PROCESS | 4839 | |7;imaging-desaturate;96;95;95;95;96;96;95;95;95;95 05:17:52 INFO - PROCESS | 4839 | |8;json-parse-financial;54;56;55;57;56;54;58;62;53;53 05:17:52 INFO - PROCESS | 4839 | |9;json-stringify-tinderbox;67;67;67;67;67;68;68;68;67;67 05:17:52 INFO - PROCESS | 4839 | |10;stanford-crypto-aes;83;85;86;86;83;84;90;84;85;86 05:17:52 INFO - PROCESS | 4839 | |11;stanford-crypto-ccm;124;121;116;114;124;119;115;124;115;123 05:17:52 INFO - PROCESS | 4839 | |12;stanford-crypto-pbkdf2;138;149;141;147;148;148;152;146;153;138 05:17:52 INFO - PROCESS | 4839 | |13;stanford-crypto-sha256-iterative;67;68;69;66;67;66;67;66;68;66 05:17:52 INFO - PROCESS | 4839 | __end_tp_report 05:17:52 INFO - PROCESS | 4839 | __start_cc_report 05:17:52 INFO - PROCESS | 4839 | _x_x_mozilla_cycle_collect,942 05:17:52 INFO - PROCESS | 4839 | __end_cc_report 05:17:52 INFO - PROCESS | 4839 | __startTimestamp1452691072793__endTimestamp 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | ------- Summary: start ------- 05:17:52 INFO - PROCESS | 4839 | Number of tests: 14 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:3.40 (3.1%) stddev-sans-first:3.61 05:17:52 INFO - PROCESS | 4839 | Values: 108.0 110.0 103.0 109.0 109.0 109.0 100.0 110.0 110.0 109.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:151.00 stddev:17.92 (11.9%) stddev-sans-first:18.64 05:17:52 INFO - PROCESS | 4839 | Values: 154.0 122.0 149.0 172.0 124.0 152.0 150.0 130.0 164.0 124.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.89 (1.2%) stddev-sans-first:1.96 05:17:52 INFO - PROCESS | 4839 | Values: 160.0 162.0 160.0 161.0 159.0 159.0 163.0 164.0 159.0 163.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#3] audio-fft Cycles:10 Average:78.70 Median:76.00 stddev:9.97 (13.1%) stddev-sans-first:10.17 05:17:52 INFO - PROCESS | 4839 | Values: 71.0 71.0 78.0 91.0 74.0 71.0 71.0 96.0 91.0 73.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:96.00 stddev:21.30 (22.2%) stddev-sans-first:22.06 05:17:52 INFO - PROCESS | 4839 | Values: 96.0 96.0 145.0 96.0 96.0 96.0 139.0 95.0 96.0 135.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:17:52 INFO - PROCESS | 4839 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:1.17 (0.8%) stddev-sans-first:1.24 05:17:52 INFO - PROCESS | 4839 | Values: 146.0 145.0 146.0 146.0 145.0 144.0 146.0 148.0 146.0 144.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:17:52 INFO - PROCESS | 4839 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:2.74 (4.9%) stddev-sans-first:2.83 05:17:52 INFO - PROCESS | 4839 | Values: 54.0 56.0 55.0 57.0 56.0 54.0 58.0 62.0 53.0 53.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 05:17:52 INFO - PROCESS | 4839 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 67.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:2.04 (2.4%) stddev-sans-first:2.01 05:17:52 INFO - PROCESS | 4839 | Values: 83.0 85.0 86.0 86.0 83.0 84.0 90.0 84.0 85.0 86.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:122.00 stddev:4.20 (3.4%) stddev-sans-first:4.12 05:17:52 INFO - PROCESS | 4839 | Values: 124.0 121.0 116.0 114.0 124.0 119.0 115.0 124.0 115.0 123.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.00 stddev:5.33 (3.6%) stddev-sans-first:4.81 05:17:52 INFO - PROCESS | 4839 | Values: 138.0 149.0 141.0 147.0 148.0 148.0 152.0 146.0 153.0 138.0 05:17:52 INFO - PROCESS | 4839 | 05:17:52 INFO - PROCESS | 4839 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 05:17:52 INFO - PROCESS | 4839 | Values: 67.0 68.0 69.0 66.0 67.0 66.0 67.0 66.0 68.0 66.0 05:17:52 INFO - PROCESS | 4839 | -------- Summary: end -------- 05:17:52 INFO - PROCESS | 4839 | 05:17:53 INFO - TEST-INFO | 4839: exit 0 05:17:53 INFO - TEST-OK | kraken | took 58661ms 05:17:53 INFO - TEST-START | v8_7 05:17:53 INFO - operating with platform_type : linux_ 05:17:53 INFO - Initialising browser for v8_7 test... 05:17:53 INFO - TEST-INFO | started process 5094 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnKQWlg/profile http://localhost:47963/getInfo.html) 05:17:57 INFO - PROCESS | 5094 | __metrics Screen width/height:1600/1200 05:17:57 INFO - PROCESS | 5094 | colorDepth:24 05:17:57 INFO - PROCESS | 5094 | Browser inner width/height: 1024/697 05:17:57 INFO - PROCESS | 5094 | __metrics 05:17:57 INFO - PROCESS | 5094 | 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:17:57 INFO - PROCESS | 5094 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:58 INFO - TEST-INFO | 5094: exit 0 05:17:58 INFO - Browser initialized. 05:17:58 INFO - Running cycle 1/1 for v8_7 test... 05:17:58 INFO - TEST-INFO | started process 5175 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnKQWlg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:10 INFO - PROCESS | 5175 | RSS: Main: 147951616 05:18:10 INFO - PROCESS | 5175 | 05:18:32 INFO - PROCESS | 5175 | Cycle 1(1): loaded http://localhost:47963/tests/v8_7/run.html (next: http://localhost:47963/tests/v8_7/run.html) 05:18:33 INFO - PROCESS | 5175 | RSS: Main: 537567232 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | __start_tp_report 05:18:33 INFO - PROCESS | 5175 | _x_x_mozilla_page_load 05:18:33 INFO - PROCESS | 5175 | _x_x_mozilla_page_load_details 05:18:33 INFO - PROCESS | 5175 | |i|pagename|runs| 05:18:33 INFO - PROCESS | 5175 | |0;Richards;166.38935108153078 05:18:33 INFO - PROCESS | 5175 | |1;DeltaBlue;191.75455417066155 05:18:33 INFO - PROCESS | 5175 | |2;Encrypt;284.9002849002849 05:18:33 INFO - PROCESS | 5175 | |3;Decrypt;5263.1578947368425 05:18:33 INFO - PROCESS | 5175 | |4;RayTrace;1108.6474501108648 05:18:33 INFO - PROCESS | 5175 | |5;Earley;789.2659826361484 05:18:33 INFO - PROCESS | 5175 | |6;Boyer;12256.09756097561 05:18:33 INFO - PROCESS | 5175 | |7;RegExp;41857.142857142855 05:18:33 INFO - PROCESS | 5175 | |8;Splay;568.1818181818181 05:18:33 INFO - PROCESS | 5175 | |9;NavierStokes;4830.917874396136 05:18:33 INFO - PROCESS | 5175 | __end_tp_report 05:18:33 INFO - PROCESS | 5175 | __startTimestamp1452691113155__endTimestamp 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | ------- Summary: start ------- 05:18:33 INFO - PROCESS | 5175 | Number of tests: 10 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 166.4 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#1] DeltaBlue Cycles:1 Average:191.75 Median:191.75 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 191.8 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#2] Encrypt Cycles:1 Average:284.90 Median:284.90 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 284.9 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 5263.2 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 1108.6 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 789.3 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 12256.1 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#7] RegExp Cycles:1 Average:41857.14 Median:41857.14 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 41857.1 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#8] Splay Cycles:1 Average:568.18 Median:568.18 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 568.2 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - PROCESS | 5175 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:18:33 INFO - PROCESS | 5175 | Values: 4830.9 05:18:33 INFO - PROCESS | 5175 | -------- Summary: end -------- 05:18:33 INFO - PROCESS | 5175 | 05:18:33 INFO - TEST-INFO | 5175: exit 0 05:18:33 INFO - TEST-OK | v8_7 | took 40311ms 05:18:33 INFO - SUITE-END | took 1210s 05:18:34 INFO - Completed test suite (00:20:11) 05:18:34 INFO - Working with test: dromaeo_css 05:18:34 INFO - Generating results file: dromaeo_css 05:18:34 INFO - Working with test: kraken 05:18:34 INFO - Generating results file: kraken 05:18:34 INFO - javascript benchmark 05:18:34 INFO - Working with test: v8_7 05:18:34 INFO - Generating results file: v8_7 05:18:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:18:34 INFO - process_Request line: dromaeo_css 6652.00 graph.html#tests=[[72,64,35]] 05:18:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:34 INFO - process_Request line: kraken 1491.50 graph.html#tests=[[232,64,35]] 05:18:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:34 INFO - process_Request line: v8_7 20093.54 graph.html#tests=[[230,64,35]] 05:18:34 INFO - RETURN: dromaeo_css: 6652.00 05:18:34 INFO - RETURN: kraken: 1491.50 05:18:34 INFO - RETURN: v8_7: 20093.54 05:18:34 INFO - javascript benchmark 05:18:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3117.407692538419, 3167.1132083016755, 3188.1232661018216, 3192.154079169019, 3206.2625596112894, 5084.694918304895, 5160.045391602552, 5182.041322355362, 5209.55718763905, 5231.947680523193, 5070.594352451804, 5092.108880945838, 5229.686218826873, 5295.655782374152, 5351.785928562853, 4717.528247175289, 4729.668923175362, 4751.524847515238, 4791.952080479203, 4820.349252850873, 449.3409959656416, 4679.953200468003, 4750.168720473903, 4778.928316075262, 4806.158922188621, 4765.976170119145, 4777.426708794949, 4777.593904518086, 4778.187708089633, 4779.761011949406, 4777.163996300668, 4777.235642297216, 4787.80848766049, 4792.712437253741, 4862.5380588844, 4744.1934871072, 4752.762361881927, 4762.023785124076, 4789.928151077736, 4798.376211092535, 5067.037262920034, 5073.568746656539, 5073.746312684351, 5082.288479612857, 5103.336566246401, 5489.58828087895, 5531.419200983879, 5541.362743284493, 5576.442355764391, 5606.0, 5578.525825304854, 5627.71861406928, 5643.153526970947, 5643.492085712305, 5645.2096706461125, 5148.382194136652, 5223.37319521656, 5275.973620131875, 5276.841694749163, 5284.445133260991, 5747.48272655463, 5753.798617048383, 5771.365149833515, 5784.71076446176, 5825.883482330414, 5507.228987941691, 5512.33851937762, 5512.5314348280845, 5514.641548299428, 5515.669059856422, 5534.363548191929, 5577.358603760538, 5583.637063590853, 5592.552595792326, 5617.915731264035, 5539.362973258047, 5565.916511252334, 5576.107822748422, 5584.022796010682, 5620.044592419298, 5551.3893471718075, 5600.551955843523, 5604.3835178130375, 5607.327120745536, 5609.5792815539, 4248.553901840324, 4313.331433627793, 4327.870163895088, 4375.759333236639, 4398.098389830077, 3891.6108389161423, 3895.844166233319, 3901.4342920276968, 3926.6466018058513, 3937.2322397132284, 5139.229115632685, 5173.689578625294, 5174.922376164361, 5175.094358487249, 5218.869528261824, 5491.148871924858, 5556.249906262684, 5583.0, 5588.413216612278, 5593.412691667398, 5106.234064890296, 5123.795048198031, 5128.615353848401, 5170.1986192140275, 5216.0, 4791.257355109963, 4794.832180873653, 4795.20879054952, 4821.4696383397795, 4825.420949486084, 5706.885862282814, 5723.8569035774435, 5764.279465066867, 5810.12848072784, 5913.999999999914, 5590.273264475592, 5596.580256480699, 5604.215409842707, 5605.943940560705, 5608.943910560843, 5781.710914454345, 5790.10253410722, 5802.883942321215, 5806.912896306643, 5807.506361959281, 5440.319960004999, 5504.889902202013, 5523.917141242965, 5525.171224316385, 5599.020171469895, 5544.528715059104, 5546.889062218653, 5547.2511210986, 5547.556195504269, 5558.555315574825, 5350.946490535045, 5394.406615272395, 5414.83755487336, 5438.15708565173, 5444.6188766785945, 5411.78352865881, 5427.83716488506, 5486.945130548644, 5504.614676972574, 5516.531094856982, 5358.22305765654, 5360.142377219626, 5361.088614935392, 5368.677879327252, 5370.19447082925, 5401.3248343957, 5427.3215848019, 5458.263134476795, 5464.098423760035, 5489.0, 5290.7354632269, 5375.81184658535, 5400.702961337164, 5445.83662490126, 5453.10023846061], "unit": "score", "name": "dojo.html", "value": 5122.490751140067}, {"lowerIsBetter": false, "replicates": [518.9325387699598, 528.5744975294888, 534.7032397019655, 549.5054450994107, 551.1044552602023, 28022.859885700567, 28594.42811143776, 28645.283867903287, 28648.28379290519, 28688.713112868863, 28907.96466371032, 29321.706782932164, 29357.119286421443, 36420.63579364205, 37009.259814803685, 8248.422610417274, 8412.11672774359, 8424.747257582283, 8426.0, 8428.072911979678, 8257.752267431957, 8413.242808147266, 8414.36892233082, 8415.28470080044, 8419.873701894476, 8358.164183581654, 8379.790505237388, 8457.281131103864, 8472.19514146155, 8490.66037358508, 8319.916800832005, 8353.540555269457, 8392.622331995075, 8420.747377578682, 8437.957810210972, 8172.305354044914, 8339.666413343459, 8340.541270230135, 8343.249107580286, 8350.039745429292, 38512.0, 38573.22853542913, 38790.61209387898, 38792.61207387918, 38995.02512437184, 3095.721385075354, 3340.8830690925943, 3540.7875527468177, 3704.0, 3760.9811950940343, 28034.579481307796, 28771.424571508454, 28812.567811482844, 28960.855195724096, 28962.0, 3594.370985077601, 3630.0, 3653.6163702811086, 3684.1894783147663, 3731.0, 256809.0, 261587.0, 261862.0, 262458.0, 262953.0, 50247.0, 51225.48774512282, 54416.45583544114, 54833.45166548363, 54840.90318193614, 60761.0, 61404.38595614076, 61429.07856382158, 61499.0, 61503.0, 14343.78484322736, 14635.195064271567, 14636.414543418145, 14636.780448293284, 14645.121292722471, 10486.108680762221, 10792.082672972729, 11095.945885140898, 11217.60738374153, 11357.261777984404, 18037.368692095715, 18073.36743213981, 18191.0, 18201.908990454962, 18233.452996409862, 7090.6100164491445, 7224.891626625605, 7326.7069317226715, 7328.303811137934, 7434.479586429006, 917.6833992272656, 939.2251392600995, 968.801395713877, 1027.1885210683477, 1027.3733022856052, 25200.873995629903, 25421.491570168862, 25429.745702543107, 25497.36256593563, 25641.230763076765, 981.082687687015, 1001.4441984698417, 1024.9590016399409, 1059.4808543813476, 1102.6251074634663, 13433.932830335785, 13492.190468571916, 13522.729545409036, 13650.0, 13674.726505469835, 326417.0, 331831.0, 333005.0, 333012.0, 333311.0, 43304.78347608242, 43400.3489947651, 43795.0, 43858.342124868155, 43863.12273754507, 1314.5464814638933, 1326.7014921642747, 1338.2104558310643, 1351.668841133909, 1355.0582345269943, 24741.381465462786, 25747.0, 25763.871180643975, 25771.484570308865, 27496.450070998868, 41127.38308925309, 41380.379294310005, 41412.0, 41429.964250892765, 41454.0, 212483.0, 214341.0, 214599.0, 214873.0, 215030.0, 26746.86626566855, 29738.405231895675, 30219.0, 30445.086647400614, 30699.2325191872, 35213.0, 37930.620693792705, 38117.23765524729, 38613.0, 38661.420078699404, 32203.999640211452, 32700.182495437806, 33133.83433082819, 33505.49741753924, 33883.49174762331, 26815.0, 32383.676163238066, 32760.74110365637, 32833.835830820695, 34846.651533485354, 32493.675063249066, 32954.34091318112, 33020.33959320848, 33026.0, 33029.834850825595, 28488.287792805346, 29993.0, 30465.847670761505, 30473.23816904595, 30506.542401863546, 23420.76579234186, 23463.88268058649, 23569.0, 23807.285781426584, 23821.523569528857], "unit": "score", "name": "ext.html", "value": 17053.978372917987}, {"lowerIsBetter": false, "replicates": [356.47776008148065, 359.76794967246127, 359.7949168973686, 363.88719496955946, 368.1514109976503, 13519.594412167626, 13769.299731048914, 15826.841731582681, 16517.83482165178, 17857.642847143066, 14440.783388249185, 15208.0, 15566.844331556682, 15700.607484812885, 15814.76277855833, 5162.92255616166, 5329.147336426173, 5356.062689029423, 5370.194470829368, 5372.865678358034, 3933.4886464759543, 4089.652379547742, 5174.249733788617, 5254.57963362932, 5686.772529098852, 5821.3305469870875, 5843.883122337572, 5853.004989151855, 5882.3529411764675, 5893.0, 5660.433956604348, 5793.449622285876, 5822.708864556797, 5845.824625261228, 5845.883082338372, 4926.778294976734, 5148.150555158394, 5162.406323272834, 5174.560162386202, 5183.041137389595, 19261.0, 19521.219151233934, 19533.511662208417, 19623.116959736846, 19652.41042768719, 1968.8424926005885, 2007.0867755171507, 2072.896355182235, 2073.1085633177727, 2129.55279391328, 8687.869681954775, 8744.475331480067, 9247.121523455327, 9393.671221507215, 9595.90404095964, 1701.8213087625868, 1747.3272789975824, 1759.7353421818368, 1833.587442825367, 1834.8532117430573, 53231.73384133093, 54512.72743636296, 54949.45050549483, 55620.721896390256, 56046.439535604935, 9826.115649591571, 10070.093691567794, 10085.546150423103, 10093.293469457214, 10142.898571014342, 13221.801672974912, 13224.008199385085, 13278.269695166666, 13303.071054697015, 13331.600051998455, 7435.739749108755, 7479.439042071866, 7487.363574096263, 7495.587742674205, 7498.737544185928, 7116.573005619679, 7117.252688467636, 7184.281571842774, 7211.567305961659, 7214.819629509304, 4316.805743741539, 4386.956130438654, 4387.034852332482, 4399.824007039747, 4484.192845287879, 1730.792304923392, 1763.0920076160787, 1793.9372121975669, 1824.6441943821094, 1856.1832793570786, 871.324723339417, 894.2041582991143, 912.4707669551644, 946.6402766948515, 990.7671697151163, 13700.862991370159, 15372.545100194848, 15957.521274361789, 16082.43711470093, 16138.273777680033, 828.9171082891784, 857.6697971281102, 872.2672954718067, 922.1930810540777, 945.2815859946353, 8844.601992910335, 9036.0, 9078.773030674154, 9136.81726365469, 9149.634014639472, 502993.0, 511806.0, 514912.0, 516308.0, 516556.0, 67566.0, 68890.0, 70595.64702176457, 70832.29167708257, 71486.64256678683, 1078.2721662877527, 1091.3779145886767, 1096.9945150274357, 1097.983530247047, 1103.178132291432, 14248.786268205778, 14264.71470570562, 15113.773293400387, 15323.310451029507, 15423.151726655142, 33108.337833243684, 33560.66439335673, 33574.49638255477, 33610.0, 35102.0, 41474.79262603668, 41970.37044444275, 42047.57952420437, 42233.36649950314, 44168.454104106204, 2971.79197456176, 2972.4500967321114, 6863.828404289933, 6983.127109111361, 7080.504364694628, 10642.787144257227, 10864.0, 11058.170637202082, 11062.723431914266, 11442.141839362248, 9651.469169195761, 9901.108900199017, 9939.254555908192, 10043.849342259726, 10147.441890696082, 9559.139677429064, 9868.733354320202, 10046.648367307109, 10348.637797677045, 10448.947755261479, 7651.770446886602, 9662.75843103928, 9760.902390976, 9924.950375248078, 10131.949340253252, 7014.228434872058, 7094.503384763017, 7132.714691412285, 7270.091238595176, 7273.3817625502425, 8153.877691834508, 9702.466364350028, 9874.555644996137, 9897.158741506764, 10120.342177758423], "unit": "score", "name": "jquery.html", "value": 7968.25959929679}, {"lowerIsBetter": false, "replicates": [1298.896088312935, 1460.5764328344778, 1466.8239811222654, 1598.896071755336, 1761.9030953297572, 6648.401643852052, 7209.711611535538, 7372.041634587496, 7372.152202496714, 7374.410047196225, 7212.170600380958, 7387.852242955138, 7393.778186654409, 7395.926040739591, 7398.297161769623, 1993.2923812046731, 2034.1151599054385, 2204.515006698528, 2222.411061068818, 2258.1306197114145, 2245.9887700561476, 2266.9319920402413, 2267.047839907243, 2275.0558518215003, 2277.544491101778, 2176.4341271269427, 2261.9095236190533, 2263.5020295534955, 2263.581237471065, 2264.241479104502, 2275.12407723027, 2286.409121715904, 2297.896594653236, 2301.953960920789, 2305.170138750049, 2265.082641530183, 2270.5685919675375, 2270.8069814065825, 2277.3054218463362, 2323.047550504285, 7497.737579184703, 7547.28300811422, 7550.282723141293, 7554.584497852616, 7559.924400756032, 4505.662075344362, 4603.033362993775, 4616.607588354994, 4620.376249206348, 4633.62930965522, 2926.6488021437563, 3045.1321373408473, 3111.066679996015, 3146.197719581515, 3157.9052628420955, 1058.698270992771, 1066.2323127348297, 1069.743261617214, 1105.4969988655223, 1113.8106521891216, 9815.901840981642, 9971.351862128939, 9978.451185184811, 9979.0, 9990.0, 4246.278132717445, 4296.162248361539, 4307.5261721210645, 4359.542248063971, 4368.628666563378, 8175.3459723222, 8234.382421318425, 8240.175982401712, 8240.464369815943, 8252.711155109542, 4672.2991551266905, 4680.157571637138, 4699.859004229878, 4711.1519926413575, 4713.0, 4372.060007098489, 4383.452068491439, 4385.057212699285, 4386.4736231652405, 4388.100439409914, 3290.210349516099, 3318.1372843060976, 3387.7120444761977, 3507.7719948203285, 3576.5171701819922, 1122.074288711816, 1141.366541569437, 1145.7078444996473, 1149.9425028748528, 1153.1236260441956, 1240.4232032105115, 1268.6384380451527, 1285.5950375631646, 1302.5180683147296, 1303.3352989974992, 6902.861942761117, 6934.757283495154, 6970.302969703091, 7051.471139664545, 7067.823304417328, 1037.600523798328, 1062.436908438529, 1086.8206745886998, 1116.916231282657, 1137.4995002199005, 5299.178627312773, 5329.9467005330225, 5356.705381203993, 5362.839114826562, 5371.4897084776885, 8426.578671066422, 8611.913880861237, 8783.604737786814, 8850.955745221232, 8865.68970086044, 8782.341324400568, 8828.646854125764, 8951.194392504705, 8952.0, 9038.683646072488, 6938.444924406035, 6984.3364880336285, 7152.499325047197, 7155.89266161008, 7166.140063192451, 6804.863902722017, 6821.147356580427, 6821.147356580427, 6831.69257383409, 6846.5892046477375, 7875.094364148196, 8098.109207987234, 8102.1087680356295, 8151.673933042612, 8251.628676709443, 8219.9589002057, 8263.710770123016, 8301.709440169565, 8308.709195178382, 8461.280791132822, 6320.873582528232, 6353.3011368748475, 6416.358364163733, 6430.678466076771, 6436.935630643634, 6452.322506136788, 6581.111549940697, 6850.21222559412, 7018.192907815666, 7024.016637670628, 6583.539152259296, 6693.598384096969, 6696.330366963265, 6774.898376524257, 6806.387425131762, 6479.5788273762055, 6524.412802847766, 6569.540132190892, 6645.302243264581, 6677.399034086956, 6531.281559028408, 6556.967215163893, 6565.310642382672, 6575.243846957661, 6584.308647592125, 5927.496162826208, 6220.813375598739, 6288.622682639057, 6291.842703932255, 6293.874122517615, 6136.969315153396, 6151.907721384094, 6166.660833654013, 6172.382761723792, 6187.071939209155], "unit": "score", "name": "mootools.html", "value": 4347.68585914052}, {"lowerIsBetter": false, "replicates": [334.74392090051106, 342.16682378408575, 345.5042014708894, 345.7268757681432, 352.1319946332289, 5810.041343178375, 5862.237909071825, 5872.119182122673, 5890.116482527628, 5936.0, 5576.5817563682685, 5602.943970560304, 5758.654480731159, 5803.332616749075, 5816.272965879265, 4445.088756804847, 4460.085682435093, 4462.4645042594775, 4472.859420847679, 4473.507914129451, 4270.103278311558, 4471.910561788763, 4472.284434490482, 4474.149911516818, 4479.238529450001, 4328.458942632171, 4338.544452832454, 4391.0559229765595, 4436.933445998313, 4439.733615983036, 4395.120975804852, 4408.14041261954, 4419.558044195554, 4423.248047831844, 4431.224535706255, 3884.8057597120314, 3886.24218277436, 3886.689064874803, 3888.0474283800368, 3888.2612303662495, 5524.751386187631, 5605.215269862222, 5611.102223644198, 5617.831465056055, 5619.719014049281, 5183.844484665466, 5191.662541934762, 5196.934628401169, 5198.636095473318, 5200.453952334989, 6161.845953851145, 6164.445199931983, 6164.784232551884, 6167.044108163242, 6167.506599472032, 4329.653627709808, 4334.934975975331, 4344.761038142901, 4353.477582690066, 4358.760268185249, 6302.149209856657, 6434.260060093103, 6444.484441244736, 6446.484281257535, 6455.838604034937, 4436.624646359639, 4436.778161091933, 4440.555944405598, 4443.533428989909, 4448.266036104072, 4471.23988921884, 4488.0, 4488.842890498817, 4489.663275254369, 4497.752623605733, 5143.897122057613, 5149.0, 5154.072266991902, 5155.716435596079, 5164.8192313268855, 6031.728572214261, 6233.594816336924, 6239.313675495692, 6241.96879015602, 6245.5628106032145, 1544.691061787647, 1545.4127431576153, 1545.6754081642755, 1546.7525195968592, 1557.0424189123835, 1055.1927775251938, 1069.13934282903, 1069.5988255385314, 1070.641335152717, 1080.9459527023616, 5861.9706901465215, 5878.911816322759, 5886.941130588725, 5899.0, 5905.940940590625, 6397.360263973658, 6400.807975760735, 6402.135711678957, 6404.167458230493, 6417.03744438338, 5728.742206600713, 5790.160426738184, 5818.44724751148, 5950.583459157818, 5978.850528736816, 3428.3486137633768, 3442.4836274558515, 3462.6364231755806, 3463.688268055887, 3468.5664291963503, 6700.899486507707, 6704.2625311215725, 6706.530542861953, 6706.698198580978, 6709.496787740939, 6353.396427339396, 6501.739930402731, 6532.118164047793, 6551.574147680481, 6559.540832141704, 6718.193816741925, 6718.7312507499155, 6723.932760672428, 6726.428253598499, 6728.058071869942, 6436.165692777536, 6453.419192272718, 6457.6771161442675, 6461.2892581816905, 6464.0627109069865, 6172.475339596005, 6296.590721603081, 6365.077063825812, 6373.330800266091, 6379.808605741835, 6688.264290927897, 6701.229358623626, 6705.731770729116, 6715.664216789043, 6718.126643536309, 4386.0789234261165, 4406.405135306821, 4408.382826404242, 4408.426904502394, 4409.052053808318, 6286.402791734778, 6444.935550644621, 6447.9355206447335, 6449.774257900951, 6452.193475815523, 6277.372262773686, 6284.685765711604, 6286.434220919956, 6289.465395441439, 6290.811275661737, 6243.625382477066, 6243.906341404973, 6246.937530624636, 6247.875042499216, 6250.968745156245, 5968.641881487125, 6111.113888486234, 6162.722677479434, 6170.321264660974, 6189.071639254148, 6319.652419116993, 6326.082718005771, 6331.810045698637, 6336.303006669171, 6340.71466784005, 6174.567780255518, 6175.320714721287, 6180.6291622502795, 6181.907271390843, 6188.133661287513], "unit": "score", "name": "prototype.html", "value": 4691.702885611301}, {"lowerIsBetter": false, "replicates": [715.5420530860247, 729.686234918985, 807.216999510475, 827.6647957577179, 828.6726742936542, 12632.62102136935, 12732.80900786489, 12740.299283539402, 12786.616401507958, 12803.551875684352, 11795.410229488534, 11937.701557461069, 12079.818802717966, 12765.234085954826, 12878.162919410232, 767.18678201107, 778.7936196907796, 779.3492433817769, 779.4855395439012, 779.7426849139798, 654.1822721598003, 659.0608383054152, 764.9005629268215, 774.380495603515, 776.8174478997431, 804.7545498622918, 807.9515229086244, 812.5327936436543, 812.6627449608405, 814.6619153051506, 676.5061505101304, 680.7515256931234, 808.0505406147782, 808.6926967752275, 810.3800592546706, 591.6420565557819, 594.4917095883044, 595.3718826637895, 595.7974288741849, 597.3309892919957, 12696.301703406309, 12727.109102362838, 12753.0, 12759.93620031894, 12772.808407873888, 12293.200941938745, 12457.75084498314, 12500.249985000839, 12884.613461596167, 12977.0, 10136.239782016304, 10221.846672299922, 10309.381437113721, 10734.677959661145, 10951.890481095166, 3545.3795585772646, 3650.2881938022097, 3685.5208822852856, 3688.4651725499652, 3700.777953322782, 45984.310235346165, 46237.30644040342, 46375.5362446378, 46665.76667116677, 47848.521514784756, 9081.0, 9112.316576256808, 9172.724818255463, 9334.486603236752, 9601.951990240004, 16761.7485737714, 16800.74798878018, 16821.158942052847, 16836.6632667346, 16882.662346752997, 7380.96309518449, 7424.146223184295, 7449.6275186241555, 7516.098068231847, 7621.733239336708, 4120.649744771668, 4166.520850102277, 4177.394277829698, 4223.13425747721, 4247.129338485603, 3086.8147911125407, 3139.403513332505, 3139.576157218792, 3147.669494703069, 3160.9051728448185, 563.6730696196196, 578.5400606517828, 578.664374662703, 581.8545363659085, 586.0359708279856, 514.4617593395794, 541.0666600114849, 555.5058680897112, 601.6570554783731, 622.7726879688881, 8112.837743245102, 8117.472364296302, 8377.664893404195, 8424.241818236389, 8567.357448191411, 530.8725905782584, 563.605476166685, 604.1662505742136, 614.4408588184731, 682.2631557917438, 3702.5927148013698, 3849.287881741887, 3920.8235629396745, 3928.738678596676, 3967.900802479961, 53981.46018539764, 58562.12156817651, 58679.0, 58884.411155887894, 58902.0, 50241.24638130431, 50488.74755626198, 50558.0, 50716.49283507118, 51573.226401604006, 45259.547404526194, 45430.545694542634, 45872.0, 46047.0, 46378.536214638094, 7345.963270183614, 7627.313541781266, 7916.84166316659, 7933.920660793549, 7992.800179995546, 33599.66400336063, 33764.32471350608, 34638.0, 34784.304313913075, 34845.47731784076, 47123.0, 48185.0, 48312.0, 48423.75788121037, 49031.754841225564, 9787.119159275699, 10382.740431489274, 10570.0, 10705.143588512745, 11251.887481125084, 12028.819567706316, 12198.14612977083, 12202.694932626755, 12229.205101668364, 12359.073069519642, 10425.687229383131, 10456.26806123564, 10591.20565957541, 10910.072643825364, 11108.38903860263, 10804.297720648132, 11074.667759967213, 11130.721731956766, 11422.200445968703, 11532.019778318601, 10933.398663073607, 11247.550097996316, 11361.091112710797, 11556.306621602731, 11668.94165529167, 9450.338476306593, 9492.477913714813, 9581.377210481296, 9698.27262955267, 9960.800783984425, 8825.0, 8889.955550222208, 9344.34589578723, 9346.15884570392, 9462.810743785223], "unit": "score", "name": "yui.html", "value": 6101.207638445284}], "name": "dromaeo_css", "value": 6651.994992270417}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 109.0, 109.0, 109.0, 100.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 149.0, 172.0, 124.0, 152.0, 150.0, 130.0, 164.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 160.0, 161.0, 159.0, 159.0, 163.0, 164.0, 159.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 78.0, 91.0, 74.0, 71.0, 71.0, 96.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 145.0, 96.0, 96.0, 96.0, 139.0, 95.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 144.0, 146.0, 148.0, 146.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 55.0, 57.0, 56.0, 54.0, 58.0, 62.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 86.0, 83.0, 84.0, 90.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 116.0, 114.0, 124.0, 119.0, 115.0, 124.0, 115.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 141.0, 147.0, 148.0, 148.0, 152.0, 146.0, 153.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 66.0, 67.0, 66.0, 67.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1491.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [191.75455417066155], "unit": "score", "name": "DeltaBlue", "value": 344.80537}, {"lowerIsBetter": false, "replicates": [284.9002849002849], "unit": "score", "name": "Encrypt", "value": 934.2953100000001}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [41857.142857142855], "unit": "score", "name": "RegExp", "value": 21.764146757679182}, {"lowerIsBetter": false, "replicates": [568.1818181818181], "unit": "score", "name": "Splay", "value": 143.42415999999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20093.537186748883}]} 05:18:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20093.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1491.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6652.00"}}} 05:18:34 INFO - Return code: 0 05:18:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:34 INFO - # TBPL SUCCESS # 05:18:34 INFO - Running post-action listener: _resource_record_post_action 05:18:34 INFO - Running post-run listener: _resource_record_post_run 05:18:35 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 40960; Write bytes: 316624896; Read time: 44; Write time: 360616 05:18:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14204928; Read time: 0; Write time: 3612 05:18:35 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 40960; Write bytes: 302419968; Read time: 44; Write time: 357004 05:18:35 INFO - Running post-run listener: _upload_blobber_files 05:18:35 INFO - Blob upload gear active. 05:18:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:18:35 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:18:35 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:18:35 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:18:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:36 INFO - (blobuploader) - INFO - Done attempting. 05:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:37 INFO - (blobuploader) - INFO - Done attempting. 05:18:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:37 INFO - Return code: 0 05:18:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:18:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50c7affd97de3ad1db8a0afa6cb22e34bfbcc14276eba14dfe7500135ad3bafba2d3e31f7c9b9a825c33c57ee57c5cf4a6f44ce91ce6c514ef552a03cfb233a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9eca53006c6c8e31e635d7634958cec2d74e4e2bc7c1fa07b2db8fb351f406d7f6e9a288b37aec7bed6f07981c5abe325ca04240d0b4aca387c29f5a0dd895e"} 05:18:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:18:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:18:37 INFO - Contents: 05:18:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50c7affd97de3ad1db8a0afa6cb22e34bfbcc14276eba14dfe7500135ad3bafba2d3e31f7c9b9a825c33c57ee57c5cf4a6f44ce91ce6c514ef552a03cfb233a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9eca53006c6c8e31e635d7634958cec2d74e4e2bc7c1fa07b2db8fb351f406d7f6e9a288b37aec7bed6f07981c5abe325ca04240d0b4aca387c29f5a0dd895e"} 05:18:37 INFO - Copying logs to upload dir... 05:18:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.047878 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-13 05:18:37.605538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:37.609596) ========= 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=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 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/50c7affd97de3ad1db8a0afa6cb22e34bfbcc14276eba14dfe7500135ad3bafba2d3e31f7c9b9a825c33c57ee57c5cf4a6f44ce91ce6c514ef552a03cfb233a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9eca53006c6c8e31e635d7634958cec2d74e4e2bc7c1fa07b2db8fb351f406d7f6e9a288b37aec7bed6f07981c5abe325ca04240d0b4aca387c29f5a0dd895e"} build_url:https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/Les615SISmuxnW1ZiyuUWg/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/50c7affd97de3ad1db8a0afa6cb22e34bfbcc14276eba14dfe7500135ad3bafba2d3e31f7c9b9a825c33c57ee57c5cf4a6f44ce91ce6c514ef552a03cfb233a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9eca53006c6c8e31e635d7634958cec2d74e4e2bc7c1fa07b2db8fb351f406d7f6e9a288b37aec7bed6f07981c5abe325ca04240d0b4aca387c29f5a0dd895e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:37.634452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:37.634839) ========= 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=62c568580acbfdaac3eec7be000001dc-1452689439.914187-1583056103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:37.718281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 05:18:37.718627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 05:18:37.718934) ========= ========= Total master_lag: 0.24 =========