builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1451955509.18 results: success (0) buildid: 20160104143020 builduid: c829b276792e400885306680b1b0f714 revision: 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.180458) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.181553) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.181885) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006412 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.209602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.209983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.273193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.273506) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.329489) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.329788) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.330187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.330534) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 16:58:29-- 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% 43.3M=0s 2016-01-04 16:58:29 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.487794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.488105) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021976 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.541636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:29.541965) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 --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 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 --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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 16:58:29,758 truncating revision to first 12 chars 2016-01-04 16:58:29,758 Setting DEBUG logging. 2016-01-04 16:58:29,758 attempt 1/10 2016-01-04 16:58:29,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d259b3dbc70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 16:58:30,008 unpacking tar archive at: fx-team-1d259b3dbc70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:30.119511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:30.119847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:30.135016) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:30.135480) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:30.135960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-04 16:58:30.136272) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:30 INFO - MultiFileLogger online at 20160104 16:58:30 in /builds/slave/test-pgo 16:58:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:58:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:58:30 INFO - {'append_to_log': False, 16:58:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:58:30 INFO - 'blob_upload_branch': 'Fx-Team', 16:58:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:58:30 INFO - 'branch': 'Fx-Team', 16:58:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:30 INFO - 'config_files': ('talos/linux_config.py',), 16:58:30 INFO - 'default_actions': ('clobber', 16:58:30 INFO - 'read-buildbot-config', 16:58:30 INFO - 'download-and-extract', 16:58:30 INFO - 'populate-webroot', 16:58:30 INFO - 'create-virtualenv', 16:58:30 INFO - 'install', 16:58:30 INFO - 'run-tests'), 16:58:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:30 INFO - 'download_minidump_stackwalk': True, 16:58:30 INFO - 'download_symbols': 'ondemand', 16:58:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:30 INFO - 'installer_path': 'installer.exe', 16:58:30 INFO - 'log_level': 'info', 16:58:30 INFO - 'log_name': 'talos', 16:58:30 INFO - 'log_to_console': True, 16:58:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:30 INFO - 'opt_config_files': (), 16:58:30 INFO - 'pip_index': False, 16:58:30 INFO - 'sps_profile': False, 16:58:30 INFO - 'sps_profile_interval': 0, 16:58:30 INFO - 'suite': 'dromaeojs-e10s', 16:58:30 INFO - 'system_bits': '32', 16:58:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:30 INFO - 'title': 'talos-linux64-ix-064', 16:58:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:30 INFO - 'use_talos_json': True, 16:58:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:58:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:30 INFO - 'work_dir': 'build'} 16:58:30 INFO - ##### 16:58:30 INFO - ##### Running clobber step. 16:58:30 INFO - ##### 16:58:30 INFO - Running pre-action listener: _resource_record_pre_action 16:58:30 INFO - Running main action method: clobber 16:58:30 INFO - rmtree: /builds/slave/test-pgo/build 16:58:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:58:30 INFO - Running post-action listener: _resource_record_post_action 16:58:30 INFO - ##### 16:58:30 INFO - ##### Running read-buildbot-config step. 16:58:30 INFO - ##### 16:58:30 INFO - Running pre-action listener: _resource_record_pre_action 16:58:30 INFO - Running main action method: read_buildbot_config 16:58:30 INFO - Using buildbot properties: 16:58:30 INFO - { 16:58:30 INFO - "project": "", 16:58:30 INFO - "product": "firefox", 16:58:30 INFO - "script_repo_revision": "production", 16:58:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:58:30 INFO - "repository": "", 16:58:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:58:30 INFO - "buildid": "20160104143020", 16:58:30 INFO - "pgo_build": "True", 16:58:30 INFO - "basedir": "/builds/slave/test-pgo", 16:58:30 INFO - "buildnumber": 175, 16:58:30 INFO - "slavename": "talos-linux64-ix-064", 16:58:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:58:30 INFO - "platform": "ubuntu64_hw", 16:58:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:58:30 INFO - "branch": "fx-team", 16:58:30 INFO - "repo_path": "integration/fx-team", 16:58:30 INFO - "revision": "1d259b3dbc70b520ffd62ae6dae536e75e7586d4", 16:58:30 INFO - "stage_platform": "linux64-pgo", 16:58:30 INFO - "builduid": "c829b276792e400885306680b1b0f714", 16:58:30 INFO - "slavebuilddir": "test" 16:58:30 INFO - } 16:58:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:58:30 INFO - Running post-action listener: _resource_record_post_action 16:58:30 INFO - ##### 16:58:30 INFO - ##### Running download-and-extract step. 16:58:30 INFO - ##### 16:58:30 INFO - Running pre-action listener: _resource_record_pre_action 16:58:30 INFO - Running main action method: download_and_extract 16:58:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:58: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')]} 16:58:30 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json 16:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json 16:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:58:37 INFO - Downloaded 1302 bytes. 16:58:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:58:37 INFO - Using the following test package requirements: 16:58:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:37 INFO - u'jsshell-linux-x86_64.zip'], 16:58:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:58:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:58:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:37 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:44 INFO - Downloaded 23198212 bytes. 16:58:44 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 16:58:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:44 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 16:58:45 INFO - Return code: 0 16:58:45 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 16:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:45 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:50 INFO - Downloaded 23198212 bytes. 16:58:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:58:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:58:51 INFO - Return code: 0 16:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:51 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:52 INFO - Downloaded 11132285 bytes. 16:58:52 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 16:58:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:52 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 16:58:53 INFO - Return code: 0 16:58:53 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')]} 16:58:53 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:58:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/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 16:58:54 INFO - Downloaded 54987672 bytes. 16:58:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:54 INFO - mkdir: /builds/slave/test-pgo/properties 16:58:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:58:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:58:54 INFO - Contents: 16:58:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:54 INFO - Running post-action listener: _resource_record_post_action 16:58:54 INFO - Running post-action listener: set_extra_try_arguments 16:58:54 INFO - ##### 16:58:54 INFO - ##### Running populate-webroot step. 16:58:54 INFO - ##### 16:58:54 INFO - Running pre-action listener: _resource_record_pre_action 16:58:54 INFO - Running main action method: populate_webroot 16:58:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:54 INFO - '--tppagecycles', 16:58:54 INFO - '7'], 16:58:54 INFO - 'tests': ['tsvgm']}}, 16:58:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:58:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'tests': ['damp', 'tps']}, 16:58:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['damp', 'tps']}, 16:58:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:58:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:54 INFO - 'other': {'tests': ['a11yr', 16:58:54 INFO - 'ts_paint', 16:58:54 INFO - 'tpaint', 16:58:54 INFO - 'sessionrestore', 16:58:54 INFO - 'sessionrestore_no_auto_restore']}, 16:58:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['a11yr', 16:58:54 INFO - 'ts_paint', 16:58:54 INFO - 'tpaint', 16:58:54 INFO - 'sessionrestore', 16:58:54 INFO - 'sessionrestore_no_auto_restore']}, 16:58:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['a11yr', 16:58:54 INFO - 'ts_paint', 16:58:54 INFO - 'tpaint', 16:58:54 INFO - 'sessionrestore', 16:58:54 INFO - 'sessionrestore_no_auto_restore']}, 16:58:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['a11yr', 16:58:54 INFO - 'ts_paint', 16:58:54 INFO - 'tpaint', 16:58:54 INFO - 'sessionrestore', 16:58:54 INFO - 'sessionrestore_no_auto_restore']}, 16:58:54 INFO - 'other_l64': {'tests': ['a11yr', 16:58:54 INFO - 'ts_paint', 16:58:54 INFO - 'tpaint', 16:58:54 INFO - 'sessionrestore', 16:58:54 INFO - 'sessionrestore_no_auto_restore']}, 16:58:54 INFO - 'other_nol64': {'tests': ['a11yr', 16:58:54 INFO - 'ts_paint', 16:58:54 INFO - 'tpaint', 16:58:54 INFO - 'sessionrestore', 16:58:54 INFO - 'sessionrestore_no_auto_restore']}, 16:58:54 INFO - 'svgr': {'tests': ['tsvgx', 16:58:54 INFO - 'tsvgr_opacity', 16:58:54 INFO - 'tart', 16:58:54 INFO - 'tscrollx', 16:58:54 INFO - 'cart']}, 16:58:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['tsvgx', 16:58:54 INFO - 'tsvgr_opacity', 16:58:54 INFO - 'tart', 16:58:54 INFO - 'tscrollx', 16:58:54 INFO - 'cart']}, 16:58:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'tests': ['tp5o']}, 16:58:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'talos_options': ['--e10s'], 16:58:54 INFO - 'tests': ['tp5o']}, 16:58:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'talos_options': ['--xperf_path', 16:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:54 INFO - 'tests': ['tp5n']}, 16:58:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:54 INFO - 'talos_options': ['--e10s', 16:58:54 INFO - '--xperf_path', 16:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:54 INFO - 'tests': ['tp5n']}}, 16:58:54 INFO - 'talos.zip': {'path': '', 16:58:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:54 INFO - Running post-action listener: _resource_record_post_action 16:58:54 INFO - ##### 16:58:54 INFO - ##### Running create-virtualenv step. 16:58:54 INFO - ##### 16:58:54 INFO - Running pre-action listener: _resource_record_pre_action 16:58:54 INFO - Running main action method: create_virtualenv 16:58:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:58:54 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 16:58:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:58:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:54 INFO - Using real prefix '/usr' 16:58:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:58:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:57 INFO - Installing pip.................done. 16:58:57 INFO - Return code: 0 16:58:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:57 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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:58:57 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 16:58:57 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 16:58:57 INFO - Using env: {'DISPLAY': ':0', 16:58:57 INFO - 'HOME': '/home/cltbld', 16:58:57 INFO - 'LANG': 'en_US.UTF-8', 16:58:57 INFO - 'LANGUAGE': 'en_US:en', 16:58:57 INFO - 'LOGNAME': 'cltbld', 16:58:57 INFO - 'MAIL': '/var/mail/cltbld', 16:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:57 INFO - 'MOZ_NO_REMOTE': '1', 16:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:57 INFO - 'NO_EM_RESTART': '1', 16:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:57 INFO - 'SHELL': '/bin/bash', 16:58:57 INFO - 'SHLVL': '1', 16:58:57 INFO - 'TERM': 'linux', 16:58:57 INFO - 'TMOUT': '86400', 16:58:57 INFO - 'USER': 'cltbld', 16:58:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:57 INFO - '_': '/tools/buildbot/bin/python'} 16:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:57 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 16:58:57 INFO - Cleaning up... 16:58:57 INFO - Return code: 0 16:58:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:57 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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:58:57 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 16:58:57 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 16:58:57 INFO - Using env: {'DISPLAY': ':0', 16:58:57 INFO - 'HOME': '/home/cltbld', 16:58:57 INFO - 'LANG': 'en_US.UTF-8', 16:58:57 INFO - 'LANGUAGE': 'en_US:en', 16:58:57 INFO - 'LOGNAME': 'cltbld', 16:58:57 INFO - 'MAIL': '/var/mail/cltbld', 16:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:57 INFO - 'MOZ_NO_REMOTE': '1', 16:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:57 INFO - 'NO_EM_RESTART': '1', 16:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:57 INFO - 'SHELL': '/bin/bash', 16:58:57 INFO - 'SHLVL': '1', 16:58:57 INFO - 'TERM': 'linux', 16:58:57 INFO - 'TMOUT': '86400', 16:58:57 INFO - 'USER': 'cltbld', 16:58:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:57 INFO - '_': '/tools/buildbot/bin/python'} 16:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:57 INFO - Downloading/unpacking psutil>=0.7.1 16:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:58:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:59 INFO - Installing collected packages: psutil 16:58:59 INFO - Running setup.py install for psutil 16:58:59 INFO - building 'psutil._psutil_linux' extension 16:58:59 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 16:58:59 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 16:58:59 INFO - building 'psutil._psutil_posix' extension 16:58:59 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 16:58:59 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 16:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:59 INFO - Successfully installed psutil 16:58:59 INFO - Cleaning up... 16:58:59 INFO - Return code: 0 16:58:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:58: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')]} 16:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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', '--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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:58:59 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 16:58:59 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 16:58:59 INFO - Using env: {'DISPLAY': ':0', 16:58:59 INFO - 'HOME': '/home/cltbld', 16:58:59 INFO - 'LANG': 'en_US.UTF-8', 16:58:59 INFO - 'LANGUAGE': 'en_US:en', 16:58:59 INFO - 'LOGNAME': 'cltbld', 16:58:59 INFO - 'MAIL': '/var/mail/cltbld', 16:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:59 INFO - 'MOZ_NO_REMOTE': '1', 16:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:59 INFO - 'NO_EM_RESTART': '1', 16:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:59 INFO - 'SHELL': '/bin/bash', 16:58:59 INFO - 'SHLVL': '1', 16:58:59 INFO - 'TERM': 'linux', 16:58:59 INFO - 'TMOUT': '86400', 16:58:59 INFO - 'USER': 'cltbld', 16:58:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:59 INFO - '_': '/tools/buildbot/bin/python'} 16:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:58:59 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 16:58:59 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 16:58:59 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 16:58:59 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 16:58:59 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 16:58:59 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 16:59:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:59:01 INFO - Installing collected packages: mozsystemmonitor 16:59:01 INFO - Running setup.py install for mozsystemmonitor 16:59:01 INFO - Successfully installed mozsystemmonitor 16:59:01 INFO - Cleaning up... 16:59:01 INFO - Return code: 0 16:59:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:59:01 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 16:59:01 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 16:59:01 INFO - Using env: {'DISPLAY': ':0', 16:59:01 INFO - 'HOME': '/home/cltbld', 16:59:01 INFO - 'LANG': 'en_US.UTF-8', 16:59:01 INFO - 'LANGUAGE': 'en_US:en', 16:59:01 INFO - 'LOGNAME': 'cltbld', 16:59:01 INFO - 'MAIL': '/var/mail/cltbld', 16:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:01 INFO - 'MOZ_NO_REMOTE': '1', 16:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:01 INFO - 'NO_EM_RESTART': '1', 16:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:01 INFO - 'SHELL': '/bin/bash', 16:59:01 INFO - 'SHLVL': '1', 16:59:01 INFO - 'TERM': 'linux', 16:59:01 INFO - 'TMOUT': '86400', 16:59:01 INFO - 'USER': 'cltbld', 16:59:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:01 INFO - '_': '/tools/buildbot/bin/python'} 16:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:59:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:59:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:04 INFO - Downloading docopt-0.6.1.tar.gz 16:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:04 INFO - Running setup.py install for blobuploader 16:59:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:59:04 INFO - Running setup.py install for requests 16:59:04 INFO - Running setup.py install for docopt 16:59:05 INFO - Successfully installed blobuploader requests docopt 16:59:05 INFO - Cleaning up... 16:59:05 INFO - Return code: 0 16:59:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:05 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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:59:05 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 16:59:05 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 16:59:05 INFO - Using env: {'DISPLAY': ':0', 16:59:05 INFO - 'HOME': '/home/cltbld', 16:59:05 INFO - 'LANG': 'en_US.UTF-8', 16:59:05 INFO - 'LANGUAGE': 'en_US:en', 16:59:05 INFO - 'LOGNAME': 'cltbld', 16:59:05 INFO - 'MAIL': '/var/mail/cltbld', 16:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:05 INFO - 'MOZ_NO_REMOTE': '1', 16:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:05 INFO - 'NO_EM_RESTART': '1', 16:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:05 INFO - 'SHELL': '/bin/bash', 16:59:05 INFO - 'SHLVL': '1', 16:59:05 INFO - 'TERM': 'linux', 16:59:05 INFO - 'TMOUT': '86400', 16:59:05 INFO - 'USER': 'cltbld', 16:59:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:05 INFO - '_': '/tools/buildbot/bin/python'} 16:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:05 INFO - Running setup.py (path:/tmp/pip-eUk2pF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:05 INFO - Running setup.py (path:/tmp/pip-A6r7k5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:05 INFO - Running setup.py (path:/tmp/pip-WkZFMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:05 INFO - Running setup.py (path:/tmp/pip-wddmSd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:05 INFO - Running setup.py (path:/tmp/pip-047Obg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:05 INFO - Running setup.py (path:/tmp/pip-Xiq_4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:05 INFO - Running setup.py (path:/tmp/pip-NBAW6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:05 INFO - Running setup.py (path:/tmp/pip-7caatd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:05 INFO - Running setup.py (path:/tmp/pip-TeNnq6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:05 INFO - Running setup.py (path:/tmp/pip-wMoA0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:06 INFO - Running setup.py (path:/tmp/pip-azArO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:06 INFO - Running setup.py (path:/tmp/pip-HWSAzB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:06 INFO - Running setup.py (path:/tmp/pip-vs4bn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:06 INFO - Running setup.py (path:/tmp/pip-GnjfNq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:06 INFO - Running setup.py (path:/tmp/pip-UvIANk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:06 INFO - Running setup.py (path:/tmp/pip-dpHiTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:06 INFO - Running setup.py (path:/tmp/pip-IdNvF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:06 INFO - Running setup.py install for manifestparser 16:59:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:59:06 INFO - Running setup.py install for mozcrash 16:59:06 INFO - Running setup.py install for mozdebug 16:59:06 INFO - Running setup.py install for mozdevice 16:59:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:59:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:59:06 INFO - Running setup.py install for mozfile 16:59:07 INFO - Running setup.py install for mozhttpd 16:59:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Running setup.py install for mozinfo 16:59:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Running setup.py install for mozInstall 16:59:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Running setup.py install for mozleak 16:59:07 INFO - Running setup.py install for mozlog 16:59:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Running setup.py install for moznetwork 16:59:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Running setup.py install for mozprocess 16:59:07 INFO - Running setup.py install for mozprofile 16:59:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Running setup.py install for mozrunner 16:59:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:59:07 INFO - Running setup.py install for mozscreenshot 16:59:08 INFO - Running setup.py install for moztest 16:59:08 INFO - Running setup.py install for mozversion 16:59:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:59:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:59:08 INFO - Cleaning up... 16:59:08 INFO - Return code: 0 16:59:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:59:08 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 16:59:08 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 16:59:08 INFO - Using env: {'DISPLAY': ':0', 16:59:08 INFO - 'HOME': '/home/cltbld', 16:59:08 INFO - 'LANG': 'en_US.UTF-8', 16:59:08 INFO - 'LANGUAGE': 'en_US:en', 16:59:08 INFO - 'LOGNAME': 'cltbld', 16:59:08 INFO - 'MAIL': '/var/mail/cltbld', 16:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:08 INFO - 'MOZ_NO_REMOTE': '1', 16:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:08 INFO - 'NO_EM_RESTART': '1', 16:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:08 INFO - 'SHELL': '/bin/bash', 16:59:08 INFO - 'SHLVL': '1', 16:59:08 INFO - 'TERM': 'linux', 16:59:08 INFO - 'TMOUT': '86400', 16:59:08 INFO - 'USER': 'cltbld', 16:59:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:08 INFO - '_': '/tools/buildbot/bin/python'} 16:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:08 INFO - Running setup.py (path:/tmp/pip-BRZFTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:08 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)) 16:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:08 INFO - Running setup.py (path:/tmp/pip-Q9QndL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:08 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)) 16:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:08 INFO - Running setup.py (path:/tmp/pip-e5N9Bb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:08 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)) 16:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:08 INFO - Running setup.py (path:/tmp/pip-tzfX5W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:08 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)) 16:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:08 INFO - Running setup.py (path:/tmp/pip-_PHTXL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:08 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)) 16:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:08 INFO - Running setup.py (path:/tmp/pip-0F1aWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:08 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)) 16:59:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:08 INFO - Running setup.py (path:/tmp/pip-DHdTEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:09 INFO - Running setup.py (path:/tmp/pip-DF8WzM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:09 INFO - Running setup.py (path:/tmp/pip-N2I29P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:09 INFO - Running setup.py (path:/tmp/pip-jIfhsj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:09 INFO - Running setup.py (path:/tmp/pip-KxMfx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:09 INFO - Running setup.py (path:/tmp/pip-P2ytkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:09 INFO - Running setup.py (path:/tmp/pip-633QOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:09 INFO - Running setup.py (path:/tmp/pip-9L0mpj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:09 INFO - Running setup.py (path:/tmp/pip-O767fI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:09 INFO - Running setup.py (path:/tmp/pip-5VIA3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:09 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)) 16:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:09 INFO - Running setup.py (path:/tmp/pip-KQLlEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:09 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)) 16:59:09 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)) 16:59:09 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)) 16:59:09 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)) 16:59:09 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)) 16:59:09 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)) 16:59:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:11 INFO - Downloading blessings-1.5.1.tar.gz 16:59:11 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 16:59:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:59:11 INFO - Installing collected packages: blessings 16:59:11 INFO - Running setup.py install for blessings 16:59:11 INFO - Successfully installed blessings 16:59:11 INFO - Cleaning up... 16:59:11 INFO - Return code: 0 16:59:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:59:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:59:11 INFO - Reading from file tmpfile_stdout 16:59:11 INFO - Current package versions: 16:59:11 INFO - argparse == 1.2.1 16:59:11 INFO - blessings == 1.5.1 16:59:11 INFO - blobuploader == 1.2.4 16:59:11 INFO - docopt == 0.6.1 16:59:11 INFO - manifestparser == 1.1 16:59:11 INFO - mozInstall == 1.12 16:59:11 INFO - mozcrash == 0.16 16:59:11 INFO - mozdebug == 0.1 16:59:11 INFO - mozdevice == 0.47 16:59:11 INFO - mozfile == 1.2 16:59:11 INFO - mozhttpd == 0.7 16:59:11 INFO - mozinfo == 0.9 16:59:11 INFO - mozleak == 0.1 16:59:11 INFO - mozlog == 3.1 16:59:11 INFO - moznetwork == 0.27 16:59:11 INFO - mozprocess == 0.22 16:59:11 INFO - mozprofile == 0.28 16:59:11 INFO - mozrunner == 6.11 16:59:11 INFO - mozscreenshot == 0.1 16:59:11 INFO - mozsystemmonitor == 0.0 16:59:11 INFO - moztest == 0.7 16:59:11 INFO - mozversion == 1.4 16:59:11 INFO - psutil == 3.1.1 16:59:11 INFO - requests == 1.2.3 16:59:11 INFO - wsgiref == 0.1.2 16:59:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:59:11 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')]} 16:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:11 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')]} 16:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:11 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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:59:11 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 16:59:11 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 16:59:11 INFO - Using env: {'DISPLAY': ':0', 16:59:11 INFO - 'HOME': '/home/cltbld', 16:59:11 INFO - 'LANG': 'en_US.UTF-8', 16:59:11 INFO - 'LANGUAGE': 'en_US:en', 16:59:11 INFO - 'LOGNAME': 'cltbld', 16:59:11 INFO - 'MAIL': '/var/mail/cltbld', 16:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:11 INFO - 'MOZ_NO_REMOTE': '1', 16:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:11 INFO - 'NO_EM_RESTART': '1', 16:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:11 INFO - 'SHELL': '/bin/bash', 16:59:11 INFO - 'SHLVL': '1', 16:59:11 INFO - 'TERM': 'linux', 16:59:11 INFO - 'TMOUT': '86400', 16:59:11 INFO - 'USER': 'cltbld', 16:59:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:11 INFO - '_': '/tools/buildbot/bin/python'} 16:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 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)) 16:59:12 INFO - Cleaning up... 16:59:12 INFO - Return code: 0 16:59:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:12 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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:59:12 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 16:59:12 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 16:59:12 INFO - Using env: {'DISPLAY': ':0', 16:59:12 INFO - 'HOME': '/home/cltbld', 16:59:12 INFO - 'LANG': 'en_US.UTF-8', 16:59:12 INFO - 'LANGUAGE': 'en_US:en', 16:59:12 INFO - 'LOGNAME': 'cltbld', 16:59:12 INFO - 'MAIL': '/var/mail/cltbld', 16:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:12 INFO - 'MOZ_NO_REMOTE': '1', 16:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:12 INFO - 'NO_EM_RESTART': '1', 16:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:12 INFO - 'SHELL': '/bin/bash', 16:59:12 INFO - 'SHLVL': '1', 16:59:12 INFO - 'TERM': 'linux', 16:59:12 INFO - 'TMOUT': '86400', 16:59:12 INFO - 'USER': 'cltbld', 16:59:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:12 INFO - '_': '/tools/buildbot/bin/python'} 16:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:12 INFO - Downloading/unpacking jsonschema 16:59:12 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 16:59:12 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 16:59:12 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 16:59:12 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 16:59:12 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 16:59:12 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 16:59:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:14 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 16:59:14 INFO - Downloading/unpacking functools32 (from jsonschema) 16:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:14 INFO - warning: no files found matching '*.txt' 16:59:14 INFO - no previously-included directories found matching 'build' 16:59:14 INFO - no previously-included directories found matching 'dist' 16:59:14 INFO - no previously-included directories found matching '.git*' 16:59:14 INFO - Installing collected packages: jsonschema, functools32 16:59:14 INFO - Running setup.py install for functools32 16:59:14 INFO - warning: no files found matching '*.txt' 16:59:14 INFO - no previously-included directories found matching 'build' 16:59:14 INFO - no previously-included directories found matching 'dist' 16:59:14 INFO - no previously-included directories found matching '.git*' 16:59:14 INFO - Successfully installed jsonschema functools32 16:59:14 INFO - Cleaning up... 16:59:14 INFO - Return code: 0 16:59:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:14 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 0x7f21edfb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', '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 16:59:14 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 16:59:14 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 16:59:14 INFO - Using env: {'DISPLAY': ':0', 16:59:14 INFO - 'HOME': '/home/cltbld', 16:59:14 INFO - 'LANG': 'en_US.UTF-8', 16:59:14 INFO - 'LANGUAGE': 'en_US:en', 16:59:14 INFO - 'LOGNAME': 'cltbld', 16:59:14 INFO - 'MAIL': '/var/mail/cltbld', 16:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:14 INFO - 'MOZ_NO_REMOTE': '1', 16:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:14 INFO - 'NO_EM_RESTART': '1', 16:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:14 INFO - 'SHELL': '/bin/bash', 16:59:14 INFO - 'SHLVL': '1', 16:59:14 INFO - 'TERM': 'linux', 16:59:14 INFO - 'TMOUT': '86400', 16:59:14 INFO - 'USER': 'cltbld', 16:59:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:14 INFO - '_': '/tools/buildbot/bin/python'} 16:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:14 INFO - Downloading/unpacking flake8 16:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:59:16 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 16:59:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:59:16 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 16:59:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:16 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 16:59:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:59:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:17 INFO - no previously-included directories found matching 'docs/_build' 16:59:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:59:17 INFO - Running setup.py install for pep8 16:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:17 INFO - no previously-included directories found matching 'docs/_build' 16:59:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:59:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:59:17 INFO - Cleaning up... 16:59:17 INFO - Return code: 0 16:59:17 INFO - Running post-action listener: _resource_record_post_action 16:59:17 INFO - Running post-action listener: _start_resource_monitoring 16:59:17 INFO - Starting resource monitoring. 16:59:17 INFO - ##### 16:59:17 INFO - ##### Running install step. 16:59:17 INFO - ##### 16:59:17 INFO - Running pre-action listener: _resource_record_pre_action 16:59:17 INFO - Running main action method: install 16:59:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:59:17 INFO - Reading from file tmpfile_stdout 16:59:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:59:17 INFO - Reading from file tmpfile_stdout 16:59:17 INFO - Output received: 16:59:17 INFO - Usage: mozinstall [options] installer 16:59:17 INFO - Options: 16:59:17 INFO - -h, --help show this help message and exit 16:59:17 INFO - -d DEST, --destination=DEST 16:59:17 INFO - Directory to install application into. [default: 16:59:17 INFO - "/builds/slave/test-pgo"] 16:59:17 INFO - --app=APP Application being installed. [default: firefox] 16:59:17 INFO - mkdir: /builds/slave/test-pgo/build/application 16:59:17 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'] 16:59:17 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 16:59:33 INFO - Reading from file tmpfile_stdout 16:59:33 INFO - Output received: 16:59:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:59:33 INFO - Running post-action listener: _resource_record_post_action 16:59:33 INFO - ##### 16:59:33 INFO - ##### Running run-tests step. 16:59:33 INFO - ##### 16:59:33 INFO - Running pre-action listener: _resource_record_pre_action 16:59:33 INFO - Running main action method: run_tests 16:59:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:59:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:59:33 INFO - Python 2.7.3 16:59:33 INFO - Return code: 0 16:59:33 INFO - grabbing minidump binary from tooltool 16:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:33 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 0x2b09840>, '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 0x2a766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a76b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:59:33 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 16:59:33 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 16:59:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:33 INFO - Return code: 0 16:59:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:59:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:59:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:59:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:59:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:59:34 INFO - Return code: 0 16:59:34 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:59:34 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:59:34 INFO - Using env: {'DISPLAY': ':0', 16:59:34 INFO - 'HOME': '/home/cltbld', 16:59:34 INFO - 'LANG': 'en_US.UTF-8', 16:59:34 INFO - 'LANGUAGE': 'en_US:en', 16:59:34 INFO - 'LOGNAME': 'cltbld', 16:59:34 INFO - 'MAIL': '/var/mail/cltbld', 16:59:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:34 INFO - 'MOZ_NO_REMOTE': '1', 16:59:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:34 INFO - 'NO_EM_RESTART': '1', 16:59:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:34 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:59:34 INFO - 'SHELL': '/bin/bash', 16:59:34 INFO - 'SHLVL': '1', 16:59:34 INFO - 'TERM': 'linux', 16:59:34 INFO - 'TMOUT': '86400', 16:59:34 INFO - 'USER': 'cltbld', 16:59:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601', 16:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:34 INFO - '_': '/tools/buildbot/bin/python'} 16:59:34 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:59:34 INFO - mozversion application_buildid: 20160104143020 16:59:34 INFO - mozversion application_changeset: 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 16:59:34 INFO - mozversion application_display_name: Nightly 16:59:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:34 INFO - mozversion application_name: Firefox 16:59:34 INFO - mozversion application_remotingname: firefox 16:59:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:59:34 INFO - mozversion application_vendor: Mozilla 16:59:34 INFO - mozversion application_version: 46.0a1 16:59:34 INFO - mozversion platform_buildid: 20160104143020 16:59:34 INFO - mozversion platform_changeset: 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 16:59:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:59:34 INFO - mozversion platform_version: 46.0a1 16:59:34 INFO - using testdate: 1451955574 16:59:34 INFO - actual date: 1451955574 16:59:34 INFO - starting webserver on 'localhost:34423' 16:59:34 INFO - SUITE-START | Running 3 tests 16:59:34 INFO - TEST-START | dromaeo_css 16:59:34 INFO - operating with platform_type : linux_ 16:59:34 INFO - Initialising browser for dromaeo_css test... 16:59:34 INFO - TEST-INFO | started process 16714 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpud85Ee/profile http://localhost:34423/getInfo.html) 16:59:39 INFO - PROCESS | 16714 | __metrics Screen width/height:1600/1200 16:59:39 INFO - PROCESS | 16714 | colorDepth:24 16:59:39 INFO - PROCESS | 16714 | Browser inner width/height: 1024/697 16:59:39 INFO - PROCESS | 16714 | __metrics 16:59:39 INFO - PROCESS | 16714 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:59:40 INFO - TEST-INFO | 16714: exit 0 16:59:40 INFO - Browser initialized. 16:59:40 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:40 INFO - TEST-INFO | started process 16846 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpud85Ee/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:52 INFO - PROCESS | 16846 | RSS: Main: 150249472 16:59:52 INFO - PROCESS | 16846 | 17:00:41 INFO - PROCESS | 16846 | 1451955641948 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] 17:02:51 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:34423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34423/tests/dromaeo/cssquery-ext.html) 17:02:52 INFO - PROCESS | 16846 | RSS: Main: 157437952 17:02:52 INFO - PROCESS | 16846 | 17:05:54 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:34423/tests/dromaeo/cssquery-ext.html (next: http://localhost:34423/tests/dromaeo/cssquery-jquery.html) 17:05:54 INFO - PROCESS | 16846 | RSS: Main: 152125440 17:05:54 INFO - PROCESS | 16846 | 17:08:56 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:34423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34423/tests/dromaeo/cssquery-mootools.html) 17:08:57 INFO - PROCESS | 16846 | RSS: Main: 155115520 17:08:57 INFO - PROCESS | 16846 | 17:11:58 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:34423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34423/tests/dromaeo/cssquery-prototype.html) 17:11:59 INFO - PROCESS | 16846 | RSS: Main: 151969792 17:11:59 INFO - PROCESS | 16846 | 17:15:01 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:34423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34423/tests/dromaeo/cssquery-yui.html) 17:15:02 INFO - PROCESS | 16846 | RSS: Main: 152690688 17:15:02 INFO - PROCESS | 16846 | 17:18:04 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:34423/tests/dromaeo/cssquery-yui.html (next: http://localhost:34423/tests/dromaeo/cssquery-dojo.html) 17:18:05 INFO - PROCESS | 16846 | RSS: Main: 154984448 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | __start_tp_report 17:18:05 INFO - PROCESS | 16846 | _x_x_mozilla_page_load 17:18:05 INFO - PROCESS | 16846 | _x_x_mozilla_page_load_details 17:18:05 INFO - PROCESS | 16846 | |i|pagename|runs| 17:18:05 INFO - PROCESS | 16846 | |0;dojo.html;3174.2857856982178;3223.161977885749;3244.707976282137;3264.9183770405743;3267.738580913527;5244.5542128919;5470.535004524615;5481.616286859921;5490.615656904019;5497.780088796453;5380.677159370441;5436.565074794017;5495.697736624484;5522.861928451791;5556.194351818994;4866.926996095061;4954.603631709455;4972.279019542164;5009.298698182258;5086.262491938666;4947.529984651453;4997.50024997501;5033.874153146164;5045.268436076767;5050.166722490784;4821.421429428474;4897.3143759873465;4913.091078150554;5032.245163225545;5039.21892106724;4962.578180854632;4999.575036121934;5011.198208286693;5023.547880690719;5074.594032477393;4801.975990120062;4974.726390048546;4984.327115839352;5006.674566153189;5069.493050694938;5238.607104467142;5275.657082289639;5284.762185701653;5295.735213239323;5339.172428273624;5857.238558987347;5867.11993201019;5870.501007414375;5883.0881213411985;5885.117232415129;5750.5687073469235;5899.203607512974;5900.881982360329;5902.61632993854;5914.497267732248;5391;5434.592405569559;5455.18172274158;5460.645058071213;5497.175423686439;5988.401159883977;5994.580379373489;5999.610025348426;6004.579679422399;6006.6696331701305;5683.2895888014;5764.971175144181;5765.279340082489;5769.8557536061935;5785.1611516329895;5701.2018317435595;5780.306363236438;5781.219535362672;5784.681842498619;5792.478676919098;5725.914111288334;5734.5125664319;5744.396838331999;5778.219940308005;5883.088121341113;5876.324222714357;5886.969780288432;5899.793507227227;5902.291724993029;5919;4492.249920102275;4495.527969563149;4509.6392288616835;4528.886777830515;4537.183307004705;3942.0539070622845;4019.5578486366476;4036.455078564415;4060.9847538115473;4064.146529228895;5415.079436495806;5430.91853622196;5456.61803673747;5493.313335833021;5533.059379905426;5891.793787217427;5892.469677729025;5908.05471124618;5929.762809487658;5967;5314.362276526842;5422.457754224625;5530.944690553123;5533.667979921218;5535.889282214333;4959.355283813154;5029.119904016782;5034.521720436553;5048.646594738407;5072.873178170502;6007.909881351783;6016.578839481194;6018.548608854353;6029.8191054268445;6030.125631783455;5711.657300561979;5818.272715910512;5856.4143585641095;5914.142449344907;5933;6095.801078121576;6096.889554637438;6099.3893660329;6114.206128133634;6119.897387362741;5808.332041815076;5847.152162936435;5869.911951320819;5870.090136028923;5891.1752354669525;5840.707964601838;5879.7060146993335;5927.051671732502;5941.7623295067715;5995;5772.105323674838;5816.621919575214;5828.009238429392;5834.562407819346;5860.970695146497;5720.3421606515785;5799.884002319845;5802.912956305743;5805.419458054161;5805.535557155333;5564.19319198722;5623.775048997994;5649.7740090397565;5653.2085508028085;5734.455226753452;5781.4507621775865;5797.594168408171;5826.359100499027;5832.9792286348875;5869.325027621878;5659.773609055592;5717.885642287048;5741.483266506035;5754.2519472469985;5755.223044889054 17:18:05 INFO - PROCESS | 16846 | |1;ext.html;549.8625343664085;552.6683989606234;559.8997968990933;567.4609121334734;596.0582279997601;38208.426873596916;38906.416403753894;39010;39056.80471597642;39069;42787;43470.34794478086;43519.56480435203;43524.56475435245;43637.56362436375;8692.826143477143;8821.294296456268;8861.601227944726;8883.24492418142;8895.377323587352;8605.870911936327;8663.350248731338;8732.08313127122;8743.256823170006;8749.431286966359;8590.656373745043;8591.226789588936;8632.525211113387;8653.870191947126;8687.218150366465;8707.738767836974;8740.956295218482;8775.78060548485;8795.648174073061;8801.383903126783;8524.744257672217;8612.5693715314;8634.654613815439;8672.696455624024;8700.086490918426;38495.807520962495;38538.61461385378;38706.41940370897;38720;38987.415188771905;2691.232998595391;3155.3216058547523;3541.6812486876047;4029.5567487576345;4067.1458993611377;27152.592711109348;27751.86124069387;28111;28374;28430.147095587166;3861.227754449121;3892.649661530476;3944.4280579316123;3959.425883246942;4012.353378469403;215645;216189;216322.91838540864;216701;217794;42432;42896;56146;58582;58938.41061589415;52268.21597676038;52268.738656307236;52373.214401784004;52561.7371913138;52834.73582632062;15323.387064517294;15399.461018864286;15519.068855868683;15559.377624895104;15571.76642350343;11692.824607630891;11860.22908510944;11868.10989175798;11872.287662740264;11873.406329683654;19344.226230950884;19572.923489207944;19616;19618.411447656592;19773.90113049454;7761.107472640719;7843.921560784319;7955.880661790078;7971.282584567417;8079.272865442021;882.3162049411757;906.664534122379;925.1765928323797;1050.1965996012902;1059.5761695321933;27912.72087279101;28424.43151137007;28736.712632873823;29022.709772902424;29159.85420072886;959.6641175588488;983.9508024598741;1007.5566750629699;1053.9894601054045;1122.680036189682;12989;13754.85080954894;13871.930640346936;13893.79159312611;14178.574642760734;312229;316577;317278;317492;317711;49986.750066249435;50068.749656251486;50625.24062139071;50678.49321506811;50718;1311.6655252910637;1312.0487646456243;1313.9802902956271;1326.529082175833;1327.7909028380059;27132.914683413233;27961.720382795913;28178.43643127167;28264;28417;41036.58963410447;41122.58877411188;41186.38220426636;41419.58580414157;41444.37833432441;184917;186939;186986;187523;187778;28065.43869122647;30905.227369315948;30905.381892362475;30907.84546077255;30988.81650977089;37149.628503714615;38319.42520862134;40277.597224027384;40752;40966.38550421806;34065.31869362648;34078;34602.307953841286;34724.82637586796;34981.65018349784;34008.65991340154;34477.448514816395;34832.30335393328;35329.82335088308;35420.64579354277;33242.66398802614;33879.830600847825;34356.82821585876;34396.48405273873;34399.48400774041;29217;29480.262993425335;31417.52873706942;31675.683243167274;32104.518432223067;23042.884785575963;23999.64000540028;24164.275071747874;24231.636525452486;24449.266522004367 17:18:05 INFO - PROCESS | 16846 | |2;jquery.html;353.78065599328403;358.66823188550603;360.46470990579;363.8999275199321;364.4496809817177;16399.83600163998;17039.659206815857;17414.303427862902;17798.91100544497;17961.101944902766;10245.334053286531;10519.63181288655;15386.076835389884;15515;15566.066036037846;4884.58481029112;5123.180291153416;5425.077736784737;5453.972730136364;5457.590680698943;5399.62202645815;5433.782648694048;5438.8912221755545;5440.591955603346;5447.782088716466;5155.7422128893595;5198.2982297389935;5287.814926477574;5303.65526240795;5389.757460914248;5265.921011184835;5267.209918512234;5281.07581173297;5282.260483532308;5301.257823904656;5010.89978200434;5119.129747942859;5134.255532947702;5135.3837539495125;5149.201873709543;11189.49647265875;11530.769384612344;12237.449314780857;12458.937705311506;12479.625611231677;1906.761654793151;1959.6178745144703;2037.246218899002;2073.40907841266;2211.535577528705;9340.626374944994;9910.355826871302;11242.550297988071;12293.815592766116;12554.435050422753;1719.1891257793598;1761.0842361971831;1783.545195975031;1802.7025540785755;1853.8331550160415;53749.731251343495;57692;58730.412695872925;59270.11094833581;60325.39674603242;9912.900870991341;10001.549930253155;10111.898881011242;10179.796404071878;10198.286119971679;12944.546940857213;12954.80567791484;13032.283224422748;13057.869421305855;13070.607881763563;7613.276738709814;7697.576633285111;7766.844663106819;7775.533467991939;7782.338501227459;7592.772216833504;7607.65765540552;7664.693412263447;7682.0397450318715;7704.460687751804;4263.317869140923;4281.293586558183;4304.4834619845815;4319.654427645781;4322.675799315064;1780.8842425242317;1794.425783749214;1798.9190486428142;1800.396867049553;1804.7383129446157;422.47612959929467;423.1431351513149;425.797746070614;462.63220739512167;859.6346552715071;10553.736156595993;11001.284916480403;11012.669619911416;11057.11543076552;11190.32858028521;431.98920026999576;442.0650324563589;444.43556683012395;450.6417398168464;455.49667617283086;5783.392743761929;5993.250843644544;6001.909971350433;6032.849178770566;6110.7861224856915;490262;509089;513035;514277;515232;72542.63728681323;75360;76150.23849761543;76173;76292.23707762851;505.25727181043806;510.8084468324378;513.8895137545446;514.3185279504671;517.503196930943;9875.604975801174;10144.797104058025;10187.84718229242;10218.233632477446;10269.897301026895;31026.534601980537;31159;31250.687493125686;31973;32374;44711;44848;44970.325445119;45799.542004579525;46268.768656156506;9657.792775903012;9840.507974601098;9857.556409961426;9871.111599955751;9873.062059104373;11637.301761894314;15725.764113538535;16737.91631041837;16878.24047917822;17128.229229684446;8925.241354484942;9228.261739060994;13303.135296205715;13438.529651462542;13511.391987360395;9821.901780982098;9994.350367226107;10069.144122749649;10106.797864042825;10141.898581014095;9653.758656033655;9916.950415247878;9952.502374881082;10025.298229124182;10413.84379234297;14809.703805923606;14964.850351496345;15034.097954122788;15340;15414.69170616559;13883.305834708022;14005.719885602028;14870.256487175815;14946.850531494545;15048.849511504744 17:18:05 INFO - PROCESS | 16846 | |3;mootools.html;1417.340936464544;1456.8761655259302;1604.9679006419872;1754.3684273661472;1777.857771378289;6848.417884479825;6905.68924398402;7497.212792656775;7750;7786.26030527099;7341.486095973284;7345.779626611197;7542.245775422455;7543.547387156775;7545.358644515209;2279.555486680098;2287.5310561334886;2298.7011688480557;2302.792748652621;2310.145246258878;2247.6291411917096;2263.660450932365;2275.8975846086882;2276.8178545716305;2290.358699564125;2244.6633005049293;2266.9319920402413;2295.070496448941;2299.7585253548386;2316.061994892071;2281.863088214696;2284.9885750571225;2306.8615883046987;2315.2591170825344;2315.386422598013;2308.8499247548857;2335.4511689752894;2336.8597884127007;2341.5433990371885;2342.6486027095903;7708.61456927157;7863.13505514393;7877.015373078365;7880.172581878935;7903;4649.395578574798;4723.07899959508;4743.7628118594275;4748.738819364934;4750.406199225097;3033.9848300758576;3040.3767227718263;3135.466970614978;3144.0882144178163;3176.6029246344206;1020.9489525523768;1032.6282538286212;1035.7824856780085;1045.2578669144916;1969.1532640964379;9759.365641233297;9861.654842080565;9889.456079915602;9909.752256193653;9911.108000279937;4191;4269.740426574168;4317.827286908551;4327.307630779123;4373.693841431069;9154.084591540926;9177.944536378402;9185.724428267162;9197.172254497127;9207.40151890125;4798.328234047236;4803.255495398219;4808.3027960945465;4813.4945830687975;4825.276208568673;4123.814428350732;4191.308434108338;4205.0959043805115;4223.68322375823;4341.479022517318;3379.5606571145595;3416.641252668484;3426.0407086015957;3432.952949350472;3480.2343484433386;1004.9497525123714;1015.6140666546665;1022.2741853284103;1046.2310202001522;1046.424466543398;1035.8808736995343;1040.812653722322;1218.9146759726912;1318.7889937609937;1334.8665133486575;7167.569945803164;7191.173015103225;7199.820004499929;7296.7446139384865;7509.812254693677;456.04231114659615;456.36337309453125;459.2009902769158;459.43718944292976;473.24753641709844;5716.571257155647;5768.596198266165;5774.422557744192;5785.537157027427;5792.333881603585;8912.465252084896;9079.636814527477;9099.1810737034;9141.085891410805;9240.122188392092;9114;9147.359684821999;9180;9206.953965230265;9272.072792720808;7179.282071792779;7241.529300595339;7245.89131163033;7262.927370726331;7265.365292809076;7162.7493037743425;7200;7206.315400036988;7220.927790722026;7224.855502890018;8004.7198348059865;8158.469699469515;8224.465409748347;8382.203690649378;8401.32789376836;8567.528785916835;8590.699325523577;8610.913890861262;8627;8648.43785153963;6782.084418603426;6859.382655561023;6928.688209030706;6951.860962780817;7025.964870175617;7270;7288.744893928687;7295.4528410368375;7297.854042919006;7297.854042919218;6677.198736151498;6867.175938887365;6911.101556797584;7023.859522809413;7027.332403421667;6789.083473730983;6811.182658081062;6875.828104297432;6893.586384816927;6942.8611427772175;6429.196350456193;6498.155239818982;6713.060171576081;6715.597064176165;6772.966135169293;6226.25284965807;6239.251289845066;6291.433770960635;6297.275813281532;6303.306636269915;6288.119663247057;6309.968450157719;6338.049292606146;6352;6359.459445947146 17:18:05 INFO - PROCESS | 16846 | |4;prototype.html;344.8172468591646;351.497358776949;354.35330521797715;358.78652201939855;360.70422253751934;6120.2043734314475;6263.467605253553;6265.968670156649;6283.465905398047;6316.368363163687;6059.454649081582;6211.751529938809;6215.564910456259;6234.220722409699;6248.750049997994;4781.617470602343;4792.496787837279;4798.592119669815;4819.34938783265;4819.686720363183;4776.665633405663;4810.542998415145;4822.252550854623;4833.709977401367;4833.854984350475;4629.213033784265;4738.549837765407;4747.216709242988;4762;4771.117343291485;4744.312074749177;4754.429468463789;4761.547652972962;4763.14263432582;4771.928421073687;4009.8997525061814;4101.4668093148;4167.1457351242925;4192.706510544263;4201.432806571104;5884.6469211847425;5911.172435858984;5911.349751527328;5919.4080591940465;5929.733162007677;5512.118061110203;5514.062609356419;5514.0901751211;5516.310461192351;5524.171374293848;6500.544961852672;6572.572782769104;6600.339966003409;6615.702293396808;6616.93383066168;4551.340055691906;4552.066826300634;4553.840615578439;4556.951901062774;4558.908821823578;6877.552959057645;6910.3089691031;6927.653617319113;6931.757388491378;6937.236903940562;4672.392588963413;4677.695949763254;4682.555157260055;4689.085628302449;4690.507496712796;4650;4738.73936933465;4741.857744267678;4747.786349614275;4751.572358487683;5487.341519017664;5489.3687225969525;5493.752781124859;5498.065328894098;5505.587080968943;6583.967080164664;6627.701753421107;6634.7393995140765;6637.668116594151;6637.767678131242;1662.4430815676642;1686.3170415981547;1693.09419460588;1695.059242120635;1695.796504419453;1063.1016790811752;1094.5020015892749;1104.1939384249383;1114.587602587048;1122.180808010157;6304.338044505353;6315.715792789244;6317.178766760292;6317.210348706411;6324.9051264231075;6818.829529261709;6833.658317084126;6839.350261725128;6856.211535673362;6872.140982377203;6210.192674952227;6213.378662133841;6281;6317.684115794192;6319.810405687745;3711.3690672585726;3712.461693054492;3719.237556300952;3726.142987112979;3733.1600389912596;6917.377436030782;7111.431085513146;7139.785806425815;7146.785596432115;7150.928490715026;7072.9646351767915;7095.716171353191;7101.325374089453;7109.857802843914;7112.35988761014;7043.2604576518725;7157.856842863218;7163.606001669854;7171.354578087893;7177.3899218567;6778.898316525355;6799.354061364163;6823.522353435212;6826.522143449911;6840.828979275558;6760.830979225559;6775.728970841308;6793.150856142982;6812.25065242813;6832.3850853421445;7003.894941575983;7087.681054352463;7095.148582170173;7170.175429825428;7189.2810718927685;4594.402727645384;4652.883677908079;4655.511171326962;4665.32352808834;4668.696534725232;6886.311368863274;6890.449648829174;6891.827704307432;6903.206131294965;6903.378695917391;6568.27748947625;6589.143411356493;6634.237062737654;6638.800835974928;6705.430038446787;6678.3989440950545;6711.161104861892;6711.6308603025345;6712.93287067123;6725.092112564741;6507.869842603216;6572.441342485942;6577.868442631217;6601.33986601336;6603.834904127435;6590.014584540211;6709.698063587248;6732.596044237362;6739.528233023641;6748;6581.967090164519;6584.835379115369;6589.934100658932;6592.307807680317;6597.472202223907 17:18:05 INFO - PROCESS | 16846 | |5;yui.html;816.0778320497836;821.4373154389244;837.7989282572182;837.9371547133965;856.3962406503416;12907.548235811748;13067.93466032671;13077.953763698904;13080.738385232302;13088.476460941574;11391.430428478563;12295;12331.630051098482;12373.257604543734;12398.628041158758;644.9451796597283;802.0896282719098;815.2784785464847;819.3035919468434;819.9590020498981;787.6140691061368;788.6845261895259;799.4284086877881;800.7077416742906;802.8394321135767;845.0155568762384;853.8932633420823;856.2422256303154;856.7044369692477;858.6737039924851;838.5849004742661;844.4215712237137;847.0089994706148;850.9574521273943;852.47146769003;612.1796792298297;615.2924137242162;621.2575971713803;621.2793159934499;621.636342739498;12322.383880805924;12334.691632709164;12424.75150496994;12430.937845310806;12434.191777534521;12248.448819803041;12397.194182378116;12600.684982875502;12874.935625321814;12939.223646581235;9535.141837234612;9764.462954537497;9871.160951319147;10031.949840250825;10057.748556286151;3539.07983924179;3580.5703315602036;3598.676119149289;3635;3704.203596226824;46053;46150.53849461496;46152.76923615394;46289.07421851578;46340.768296158305;9742.707718768306;9742.805143897082;9955.950220248853;9993.600255989824;10004.749881253027;18158.45524634263;18166.18252178655;18214.45356639303;18258.26966921308;18265.086745662662;6940.119404169252;7100;7172.784816455514;7181.35367816899;7273.6726847292;4176.937345939813;4202.894927626834;4213.747175169438;4253.21315556623;4265.893352666209;3060.3726236121543;3080.8151510909415;3101.8138911665374;3102.720755132049;3106.891258805931;571.0520535910368;572.0846645367462;577.8353169346716;582.0251079441917;601.3265143039823;538.2088330154745;560.5655616896937;571.5998800839429;651.4462706699268;659.2418718473698;7394.334509894135;7905.095285956927;8159.632816523152;8286.254237118688;8480.957595212109;574.2850151561333;622.1103821535248;642.1619786178987;642.9164208652845;672.5561129654404;3963.7819919904105;4058;4205.179989902001;4353.804078816461;4370.475542934804;52126;52195.73902130465;52315.215271770954;52606.736966315686;53271.73364133154;48539.51460485421;48684.75657621689;49229.261561076615;49859.25211121836;49901;42974.570254297054;43246.78376608097;43676.126477470905;43746.56253437488;44141.7792911027;8717.782055448664;8872.245859101791;8889.377743558147;8904.599293031699;9004.954975225082;32474.675253247166;32898.17754556155;32963.835180823946;33370.83314583411;33793.49309760307;38458.42312365373;38824;39242.2151556973;43358.78320608377;43690.90772730707;10639.308444951053;10835.945820271163;10866.891331086588;10908.836367454336;10932.672019839418;12278.631641050782;12406;12939.935300323437;12986.35068246565;13002.349882505649;9949.950250248703;10534.473276335999;10993;11009.61466348674;11017.44912754375;11156.888431115585;11297.774044519228;11305.321680699184;11424.657260282205;11711.824322634997;9356.578953946953;10991.780164396507;11089.94455027752;11447.084233261485;11575.247608905394;9875.111239988435;9891.35706179096;9933.304668673123;10210.030047145508;10341.069303762697;8588.355873309401;9063.773405664911;9711.9028809711;9752;9790.608375664893 17:18:05 INFO - PROCESS | 16846 | __end_tp_report 17:18:05 INFO - PROCESS | 16846 | __start_cc_report 17:18:05 INFO - PROCESS | 16846 | _x_x_mozilla_cycle_collect,310 17:18:05 INFO - PROCESS | 16846 | __end_cc_report 17:18:05 INFO - PROCESS | 16846 | __startTimestamp1451956685227__endTimestamp 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | ------- Summary: start ------- 17:18:05 INFO - PROCESS | 16846 | Number of tests: 6 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | [#0] dojo.html Cycles:165 Average:5445.53 Median:5711.66 stddev:614.17 (10.8%) stddev-sans-first:589.65 17:18:05 INFO - PROCESS | 16846 | Values: 3174.3 3223.2 3244.7 3264.9 3267.7 5244.6 5470.5 5481.6 5490.6 5497.8 5380.7 5436.6 5495.7 5522.9 5556.2 4866.9 4954.6 4972.3 5009.3 5086.3 4947.5 4997.5 5033.9 5045.3 5050.2 4821.4 4897.3 4913.1 5032.2 5039.2 4962.6 4999.6 5011.2 5023.5 5074.6 4802.0 4974.7 4984.3 5006.7 5069.5 5238.6 5275.7 5284.8 5295.7 5339.2 5857.2 5867.1 5870.5 5883.1 5885.1 5750.6 5899.2 5900.9 5902.6 5914.5 5391.0 5434.6 5455.2 5460.6 5497.2 5988.4 5994.6 5999.6 6004.6 6006.7 5683.3 5765.0 5765.3 5769.9 5785.2 5701.2 5780.3 5781.2 5784.7 5792.5 5725.9 5734.5 5744.4 5778.2 5883.1 5876.3 5887.0 5899.8 5902.3 5919.0 4492.2 4495.5 4509.6 4528.9 4537.2 3942.1 4019.6 4036.5 4061.0 4064.1 5415.1 5430.9 5456.6 5493.3 5533.1 5891.8 5892.5 5908.1 5929.8 5967.0 5314.4 5422.5 5530.9 5533.7 5535.9 4959.4 5029.1 5034.5 5048.6 5072.9 6007.9 6016.6 6018.5 6029.8 6030.1 5711.7 5818.3 5856.4 5914.1 5933.0 6095.8 6096.9 6099.4 6114.2 6119.9 5808.3 5847.2 5869.9 5870.1 5891.2 5840.7 5879.7 5927.1 5941.8 5995.0 5772.1 5816.6 5828.0 5834.6 5861.0 5720.3 5799.9 5802.9 5805.4 5805.5 5564.2 5623.8 5649.8 5653.2 5734.5 5781.5 5797.6 5826.4 5833.0 5869.3 5659.8 5717.9 5741.5 5754.3 5755.2 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | [#1] ext.html Cycles:180 Average:40901.19 Median:19435.75 stddev:64209.31 (330.4%) stddev-sans-first:64317.95 17:18:05 INFO - PROCESS | 16846 | Values: 549.9 552.7 559.9 567.5 596.1 38208.4 38906.4 39010.0 39056.8 39069.0 42787.0 43470.3 43519.6 43524.6 43637.6 8692.8 8821.3 8861.6 8883.2 8895.4 8605.9 8663.4 8732.1 8743.3 8749.4 8590.7 8591.2 8632.5 8653.9 8687.2 8707.7 8741.0 8775.8 8795.6 8801.4 8524.7 8612.6 8634.7 8672.7 8700.1 38495.8 38538.6 38706.4 38720.0 38987.4 2691.2 3155.3 3541.7 4029.6 4067.1 27152.6 27751.9 28111.0 28374.0 28430.1 3861.2 3892.6 3944.4 3959.4 4012.4 215645.0 216189.0 216322.9 216701.0 217794.0 42432.0 42896.0 56146.0 58582.0 58938.4 52268.2 52268.7 52373.2 52561.7 52834.7 15323.4 15399.5 15519.1 15559.4 15571.8 11692.8 11860.2 11868.1 11872.3 11873.4 19344.2 19572.9 19616.0 19618.4 19773.9 7761.1 7843.9 7955.9 7971.3 8079.3 882.3 906.7 925.2 1050.2 1059.6 27912.7 28424.4 28736.7 29022.7 29159.9 959.7 984.0 1007.6 1054.0 1122.7 12989.0 13754.9 13871.9 13893.8 14178.6 312229.0 316577.0 317278.0 317492.0 317711.0 49986.8 50068.7 50625.2 50678.5 50718.0 1311.7 1312.0 1314.0 1326.5 1327.8 27132.9 27961.7 28178.4 28264.0 28417.0 41036.6 41122.6 41186.4 41419.6 41444.4 184917.0 186939.0 186986.0 187523.0 187778.0 28065.4 30905.2 30905.4 30907.8 30988.8 37149.6 38319.4 40277.6 40752.0 40966.4 34065.3 34078.0 34602.3 34724.8 34981.7 34008.7 34477.4 34832.3 35329.8 35420.6 33242.7 33879.8 34356.8 34396.5 34399.5 29217.0 29480.3 31417.5 31675.7 32104.5 23042.9 23999.6 24164.3 24231.6 24449.3 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | [#2] jquery.html Cycles:180 Average:26744.49 Median:2375.82 stddev:83158.95 (3500.2%) stddev-sans-first:83368.62 17:18:05 INFO - PROCESS | 16846 | Values: 353.8 358.7 360.5 363.9 364.4 16399.8 17039.7 17414.3 17798.9 17961.1 10245.3 10519.6 15386.1 15515.0 15566.1 4884.6 5123.2 5425.1 5454.0 5457.6 5399.6 5433.8 5438.9 5440.6 5447.8 5155.7 5198.3 5287.8 5303.7 5389.8 5265.9 5267.2 5281.1 5282.3 5301.3 5010.9 5119.1 5134.3 5135.4 5149.2 11189.5 11530.8 12237.4 12458.9 12479.6 1906.8 1959.6 2037.2 2073.4 2211.5 9340.6 9910.4 11242.6 12293.8 12554.4 1719.2 1761.1 1783.5 1802.7 1853.8 53749.7 57692.0 58730.4 59270.1 60325.4 9912.9 10001.5 10111.9 10179.8 10198.3 12944.5 12954.8 13032.3 13057.9 13070.6 7613.3 7697.6 7766.8 7775.5 7782.3 7592.8 7607.7 7664.7 7682.0 7704.5 4263.3 4281.3 4304.5 4319.7 4322.7 1780.9 1794.4 1798.9 1800.4 1804.7 422.5 423.1 425.8 462.6 859.6 10553.7 11001.3 11012.7 11057.1 11190.3 432.0 442.1 444.4 450.6 455.5 5783.4 5993.3 6001.9 6032.8 6110.8 490262.0 509089.0 513035.0 514277.0 515232.0 72542.6 75360.0 76150.2 76173.0 76292.2 505.3 510.8 513.9 514.3 517.5 9875.6 10144.8 10187.8 10218.2 10269.9 31026.5 31159.0 31250.7 31973.0 32374.0 44711.0 44848.0 44970.3 45799.5 46268.8 9657.8 9840.5 9857.6 9871.1 9873.1 11637.3 15725.8 16737.9 16878.2 17128.2 8925.2 9228.3 13303.1 13438.5 13511.4 9821.9 9994.4 10069.1 10106.8 10141.9 9653.8 9917.0 9952.5 10025.3 10413.8 14809.7 14964.9 15034.1 15340.0 15414.7 13883.3 14005.7 14870.3 14946.9 15048.8 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | [#3] mootools.html Cycles:180 Average:5363.27 Median:6306.64 stddev:2759.32 (43.8%) stddev-sans-first:2751.12 17:18:05 INFO - PROCESS | 16846 | Values: 1417.3 1456.9 1605.0 1754.4 1777.9 6848.4 6905.7 7497.2 7750.0 7786.3 7341.5 7345.8 7542.2 7543.5 7545.4 2279.6 2287.5 2298.7 2302.8 2310.1 2247.6 2263.7 2275.9 2276.8 2290.4 2244.7 2266.9 2295.1 2299.8 2316.1 2281.9 2285.0 2306.9 2315.3 2315.4 2308.8 2335.5 2336.9 2341.5 2342.6 7708.6 7863.1 7877.0 7880.2 7903.0 4649.4 4723.1 4743.8 4748.7 4750.4 3034.0 3040.4 3135.5 3144.1 3176.6 1020.9 1032.6 1035.8 1045.3 1969.2 9759.4 9861.7 9889.5 9909.8 9911.1 4191.0 4269.7 4317.8 4327.3 4373.7 9154.1 9177.9 9185.7 9197.2 9207.4 4798.3 4803.3 4808.3 4813.5 4825.3 4123.8 4191.3 4205.1 4223.7 4341.5 3379.6 3416.6 3426.0 3433.0 3480.2 1004.9 1015.6 1022.3 1046.2 1046.4 1035.9 1040.8 1218.9 1318.8 1334.9 7167.6 7191.2 7199.8 7296.7 7509.8 456.0 456.4 459.2 459.4 473.2 5716.6 5768.6 5774.4 5785.5 5792.3 8912.5 9079.6 9099.2 9141.1 9240.1 9114.0 9147.4 9180.0 9207.0 9272.1 7179.3 7241.5 7245.9 7262.9 7265.4 7162.7 7200.0 7206.3 7220.9 7224.9 8004.7 8158.5 8224.5 8382.2 8401.3 8567.5 8590.7 8610.9 8627.0 8648.4 6782.1 6859.4 6928.7 6951.9 7026.0 7270.0 7288.7 7295.5 7297.9 7297.9 6677.2 6867.2 6911.1 7023.9 7027.3 6789.1 6811.2 6875.8 6893.6 6942.9 6429.2 6498.2 6713.1 6715.6 6773.0 6226.3 6239.3 6291.4 6297.3 6303.3 6288.1 6310.0 6338.0 6352.0 6359.5 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | [#4] prototype.html Cycles:180 Average:5549.37 Median:6282.23 stddev:1682.38 (26.8%) stddev-sans-first:1641.12 17:18:05 INFO - PROCESS | 16846 | Values: 344.8 351.5 354.4 358.8 360.7 6120.2 6263.5 6266.0 6283.5 6316.4 6059.5 6211.8 6215.6 6234.2 6248.8 4781.6 4792.5 4798.6 4819.3 4819.7 4776.7 4810.5 4822.3 4833.7 4833.9 4629.2 4738.5 4747.2 4762.0 4771.1 4744.3 4754.4 4761.5 4763.1 4771.9 4009.9 4101.5 4167.1 4192.7 4201.4 5884.6 5911.2 5911.3 5919.4 5929.7 5512.1 5514.1 5514.1 5516.3 5524.2 6500.5 6572.6 6600.3 6615.7 6616.9 4551.3 4552.1 4553.8 4557.0 4558.9 6877.6 6910.3 6927.7 6931.8 6937.2 4672.4 4677.7 4682.6 4689.1 4690.5 4650.0 4738.7 4741.9 4747.8 4751.6 5487.3 5489.4 5493.8 5498.1 5505.6 6584.0 6627.7 6634.7 6637.7 6637.8 1662.4 1686.3 1693.1 1695.1 1695.8 1063.1 1094.5 1104.2 1114.6 1122.2 6304.3 6315.7 6317.2 6317.2 6324.9 6818.8 6833.7 6839.4 6856.2 6872.1 6210.2 6213.4 6281.0 6317.7 6319.8 3711.4 3712.5 3719.2 3726.1 3733.2 6917.4 7111.4 7139.8 7146.8 7150.9 7073.0 7095.7 7101.3 7109.9 7112.4 7043.3 7157.9 7163.6 7171.4 7177.4 6778.9 6799.4 6823.5 6826.5 6840.8 6760.8 6775.7 6793.2 6812.3 6832.4 7003.9 7087.7 7095.1 7170.2 7189.3 4594.4 4652.9 4655.5 4665.3 4668.7 6886.3 6890.4 6891.8 6903.2 6903.4 6568.3 6589.1 6634.2 6638.8 6705.4 6678.4 6711.2 6711.6 6712.9 6725.1 6507.9 6572.4 6577.9 6601.3 6603.8 6590.0 6709.7 6732.6 6739.5 6748.0 6582.0 6584.8 6589.9 6592.3 6597.5 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - PROCESS | 16846 | [#5] yui.html Cycles:180 Average:13198.43 Median:46220.92 stddev:14900.23 (32.2%) stddev-sans-first:14913.02 17:18:05 INFO - PROCESS | 16846 | Values: 816.1 821.4 837.8 837.9 856.4 12907.5 13067.9 13078.0 13080.7 13088.5 11391.4 12295.0 12331.6 12373.3 12398.6 644.9 802.1 815.3 819.3 820.0 787.6 788.7 799.4 800.7 802.8 845.0 853.9 856.2 856.7 858.7 838.6 844.4 847.0 851.0 852.5 612.2 615.3 621.3 621.3 621.6 12322.4 12334.7 12424.8 12430.9 12434.2 12248.4 12397.2 12600.7 12874.9 12939.2 9535.1 9764.5 9871.2 10031.9 10057.7 3539.1 3580.6 3598.7 3635.0 3704.2 46053.0 46150.5 46152.8 46289.1 46340.8 9742.7 9742.8 9956.0 9993.6 10004.7 18158.5 18166.2 18214.5 18258.3 18265.1 6940.1 7100.0 7172.8 7181.4 7273.7 4176.9 4202.9 4213.7 4253.2 4265.9 3060.4 3080.8 3101.8 3102.7 3106.9 571.1 572.1 577.8 582.0 601.3 538.2 560.6 571.6 651.4 659.2 7394.3 7905.1 8159.6 8286.3 8481.0 574.3 622.1 642.2 642.9 672.6 3963.8 4058.0 4205.2 4353.8 4370.5 52126.0 52195.7 52315.2 52606.7 53271.7 48539.5 48684.8 49229.3 49859.3 49901.0 42974.6 43246.8 43676.1 43746.6 44141.8 8717.8 8872.2 8889.4 8904.6 9005.0 32474.7 32898.2 32963.8 33370.8 33793.5 38458.4 38824.0 39242.2 43358.8 43690.9 10639.3 10835.9 10866.9 10908.8 10932.7 12278.6 12406.0 12939.9 12986.4 13002.3 9950.0 10534.5 10993.0 11009.6 11017.4 11156.9 11297.8 11305.3 11424.7 11711.8 9356.6 10991.8 11089.9 11447.1 11575.2 9875.1 9891.4 9933.3 10210.0 10341.1 8588.4 9063.8 9711.9 9752.0 9790.6 17:18:05 INFO - PROCESS | 16846 | -------- Summary: end -------- 17:18:05 INFO - PROCESS | 16846 | 17:18:05 INFO - TEST-INFO | 16846: exit 0 17:18:05 INFO - TEST-OK | dromaeo_css | took 1111331ms 17:18:05 INFO - TEST-START | kraken 17:18:05 INFO - operating with platform_type : linux_ 17:18:05 INFO - Initialising browser for kraken test... 17:18:05 INFO - TEST-INFO | started process 17088 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOpI_tF/profile http://localhost:34423/getInfo.html) 17:18:10 INFO - PROCESS | 17088 | __metrics Screen width/height:1600/1200 17:18:10 INFO - PROCESS | 17088 | colorDepth:24 17:18:10 INFO - PROCESS | 17088 | Browser inner width/height: 1024/697 17:18:10 INFO - PROCESS | 17088 | __metrics 17:18:10 INFO - PROCESS | 17088 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:18:11 INFO - TEST-INFO | 17088: exit 0 17:18:11 INFO - Browser initialized. 17:18:11 INFO - Running cycle 1/1 for kraken test... 17:18:11 INFO - TEST-INFO | started process 17209 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOpI_tF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:23 INFO - PROCESS | 17209 | RSS: Main: 150962176 17:18:23 INFO - PROCESS | 17209 | 17:18:26 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34423/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:26 INFO - PROCESS | 17209 | RSS: Main: 151437312 17:18:26 INFO - PROCESS | 17209 | 17:18:29 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34423/tests/kraken/driver.html?testName=audio-dft) 17:18:30 INFO - PROCESS | 17209 | RSS: Main: 152002560 17:18:30 INFO - PROCESS | 17209 | 17:18:32 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34423/tests/kraken/driver.html?testName=audio-fft) 17:18:33 INFO - PROCESS | 17209 | RSS: Main: 145760256 17:18:33 INFO - PROCESS | 17209 | 17:18:35 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34423/tests/kraken/driver.html?testName=audio-oscillator) 17:18:36 INFO - PROCESS | 17209 | RSS: Main: 146546688 17:18:36 INFO - PROCESS | 17209 | 17:18:38 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:39 INFO - PROCESS | 17209 | RSS: Main: 147222528 17:18:39 INFO - PROCESS | 17209 | 17:18:42 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34423/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:42 INFO - PROCESS | 17209 | RSS: Main: 147697664 17:18:42 INFO - PROCESS | 17209 | 17:18:46 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34423/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:46 INFO - PROCESS | 17209 | RSS: Main: 148058112 17:18:46 INFO - PROCESS | 17209 | 17:18:49 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34423/tests/kraken/driver.html?testName=json-parse-financial) 17:18:50 INFO - PROCESS | 17209 | RSS: Main: 148414464 17:18:50 INFO - PROCESS | 17209 | 17:18:51 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:52 INFO - PROCESS | 17209 | RSS: Main: 148959232 17:18:52 INFO - PROCESS | 17209 | 17:18:54 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:54 INFO - PROCESS | 17209 | RSS: Main: 149188608 17:18:54 INFO - PROCESS | 17209 | 17:18:56 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:57 INFO - PROCESS | 17209 | RSS: Main: 149585920 17:18:57 INFO - PROCESS | 17209 | 17:18:59 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:00 INFO - PROCESS | 17209 | RSS: Main: 147755008 17:19:00 INFO - PROCESS | 17209 | 17:19:02 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:03 INFO - PROCESS | 17209 | RSS: Main: 149073920 17:19:03 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:34423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34423/tests/kraken/driver.html?testName=ai-astar) 17:19:05 INFO - PROCESS | 17209 | RSS: Main: 150151168 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | __start_tp_report 17:19:05 INFO - PROCESS | 17209 | _x_x_mozilla_page_load 17:19:05 INFO - PROCESS | 17209 | _x_x_mozilla_page_load_details 17:19:05 INFO - PROCESS | 17209 | |i|pagename|runs| 17:19:05 INFO - PROCESS | 17209 | |0;ai-astar;113;105;113;111;112;123;112;111;112;111 17:19:05 INFO - PROCESS | 17209 | |1;audio-beat-detection;153;127;151;164;134;155;160;129;173;127 17:19:05 INFO - PROCESS | 17209 | |2;audio-dft;163;163;165;162;161;163;167;170;165;165 17:19:05 INFO - PROCESS | 17209 | |3;audio-fft;71;75;74;74;71;74;72;140;72;74 17:19:05 INFO - PROCESS | 17209 | |4;audio-oscillator;95;96;142;97;97;97;140;96;97;151 17:19:05 INFO - PROCESS | 17209 | |5;imaging-gaussian-blur;110;111;110;109;110;110;111;110;110;110 17:19:05 INFO - PROCESS | 17209 | |6;imaging-darkroom;147;148;148;146;147;148;147;147;150;147 17:19:05 INFO - PROCESS | 17209 | |7;imaging-desaturate;96;101;99;96;96;97;96;96;96;96 17:19:05 INFO - PROCESS | 17209 | |8;json-parse-financial;59;59;60;58;61;59;59;69;57;59 17:19:05 INFO - PROCESS | 17209 | |9;json-stringify-tinderbox;67;67;67;67;67;66;66;67;67;68 17:19:05 INFO - PROCESS | 17209 | |10;stanford-crypto-aes;86;86;86;87;87;86;90;87;86;87 17:19:05 INFO - PROCESS | 17209 | |11;stanford-crypto-ccm;123;123;130;125;121;120;121;122;120;119 17:19:05 INFO - PROCESS | 17209 | |12;stanford-crypto-pbkdf2;150;145;162;151;145;142;154;153;153;145 17:19:05 INFO - PROCESS | 17209 | |13;stanford-crypto-sha256-iterative;68;69;71;73;68;68;69;71;70;80 17:19:05 INFO - PROCESS | 17209 | __end_tp_report 17:19:05 INFO - PROCESS | 17209 | __start_cc_report 17:19:05 INFO - PROCESS | 17209 | _x_x_mozilla_cycle_collect,762 17:19:05 INFO - PROCESS | 17209 | __end_cc_report 17:19:05 INFO - PROCESS | 17209 | __startTimestamp1451956745558__endTimestamp 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | ------- Summary: start ------- 17:19:05 INFO - PROCESS | 17209 | Number of tests: 14 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.40 (3.9%) stddev-sans-first:4.66 17:19:05 INFO - PROCESS | 17209 | Values: 113.0 105.0 113.0 111.0 112.0 123.0 112.0 111.0 112.0 111.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:154.00 stddev:16.81 (10.9%) stddev-sans-first:17.70 17:19:05 INFO - PROCESS | 17209 | Values: 153.0 127.0 151.0 164.0 134.0 155.0 160.0 129.0 173.0 127.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.63 (1.6%) stddev-sans-first:2.74 17:19:05 INFO - PROCESS | 17209 | Values: 163.0 163.0 165.0 162.0 161.0 163.0 167.0 170.0 165.0 165.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#3] audio-fft Cycles:10 Average:79.70 Median:74.00 stddev:21.23 (28.7%) stddev-sans-first:22.29 17:19:05 INFO - PROCESS | 17209 | Values: 71.0 75.0 74.0 74.0 71.0 74.0 72.0 140.0 72.0 74.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:96.50 stddev:23.31 (24.2%) stddev-sans-first:24.02 17:19:05 INFO - PROCESS | 17209 | Values: 95.0 96.0 142.0 97.0 97.0 97.0 140.0 96.0 97.0 151.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:19:05 INFO - PROCESS | 17209 | Values: 110.0 111.0 110.0 109.0 110.0 110.0 111.0 110.0 110.0 110.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:19:05 INFO - PROCESS | 17209 | Values: 147.0 148.0 148.0 146.0 147.0 148.0 147.0 147.0 150.0 147.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:1.73 (1.8%) stddev-sans-first:1.80 17:19:05 INFO - PROCESS | 17209 | Values: 96.0 101.0 99.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.00 stddev:3.33 (5.6%) stddev-sans-first:3.52 17:19:05 INFO - PROCESS | 17209 | Values: 59.0 59.0 60.0 58.0 61.0 59.0 59.0 69.0 57.0 59.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 17:19:05 INFO - PROCESS | 17209 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 66.0 67.0 67.0 68.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 17:19:05 INFO - PROCESS | 17209 | Values: 86.0 86.0 86.0 87.0 87.0 86.0 90.0 87.0 86.0 87.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:122.50 stddev:3.20 (2.6%) stddev-sans-first:3.39 17:19:05 INFO - PROCESS | 17209 | Values: 123.0 123.0 130.0 125.0 121.0 120.0 121.0 122.0 120.0 119.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:152.00 stddev:5.94 (3.9%) stddev-sans-first:6.30 17:19:05 INFO - PROCESS | 17209 | Values: 150.0 145.0 162.0 151.0 145.0 142.0 154.0 153.0 153.0 145.0 17:19:05 INFO - PROCESS | 17209 | 17:19:05 INFO - PROCESS | 17209 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:3.65 (5.2%) stddev-sans-first:3.74 17:19:05 INFO - PROCESS | 17209 | Values: 68.0 69.0 71.0 73.0 68.0 68.0 69.0 71.0 70.0 80.0 17:19:05 INFO - PROCESS | 17209 | -------- Summary: end -------- 17:19:05 INFO - PROCESS | 17209 | 17:19:06 INFO - TEST-INFO | 17209: exit 0 17:19:06 INFO - TEST-OK | kraken | took 60509ms 17:19:06 INFO - TEST-START | v8_7 17:19:06 INFO - operating with platform_type : linux_ 17:19:06 INFO - Initialising browser for v8_7 test... 17:19:06 INFO - TEST-INFO | started process 17497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n5XwO/profile http://localhost:34423/getInfo.html) 17:19:11 INFO - PROCESS | 17497 | __metrics Screen width/height:1600/1200 17:19:11 INFO - PROCESS | 17497 | colorDepth:24 17:19:11 INFO - PROCESS | 17497 | Browser inner width/height: 1024/697 17:19:11 INFO - PROCESS | 17497 | __metrics 17:19:11 INFO - PROCESS | 17497 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:19:12 INFO - TEST-INFO | 17497: exit 0 17:19:12 INFO - Browser initialized. 17:19:12 INFO - Running cycle 1/1 for v8_7 test... 17:19:12 INFO - TEST-INFO | started process 17621 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n5XwO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:24 INFO - PROCESS | 17621 | RSS: Main: 150732800 17:19:24 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | Cycle 1(1): loaded http://localhost:34423/tests/v8_7/run.html (next: http://localhost:34423/tests/v8_7/run.html) 17:19:45 INFO - PROCESS | 17621 | RSS: Main: 146968576 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | __start_tp_report 17:19:45 INFO - PROCESS | 17621 | _x_x_mozilla_page_load 17:19:45 INFO - PROCESS | 17621 | _x_x_mozilla_page_load_details 17:19:45 INFO - PROCESS | 17621 | |i|pagename|runs| 17:19:45 INFO - PROCESS | 17621 | |0;Richards;166.91704223001167 17:19:45 INFO - PROCESS | 17621 | |1;DeltaBlue;191.0219675262655 17:19:45 INFO - PROCESS | 17621 | |2;Encrypt;279.6420581655481 17:19:45 INFO - PROCESS | 17621 | |3;Decrypt;5175.257731958763 17:19:45 INFO - PROCESS | 17621 | |4;RayTrace;1075.268817204301 17:19:45 INFO - PROCESS | 17621 | |5;Earley;705.2186177715091 17:19:45 INFO - PROCESS | 17621 | |6;Boyer;12168.674698795181 17:19:45 INFO - PROCESS | 17621 | |7;RegExp;26000 17:19:45 INFO - PROCESS | 17621 | |8;Splay;677.5067750677507 17:19:45 INFO - PROCESS | 17621 | |9;NavierStokes;4845.410628019324 17:19:45 INFO - PROCESS | 17621 | __end_tp_report 17:19:45 INFO - PROCESS | 17621 | __startTimestamp1451956785844__endTimestamp 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | ------- Summary: start ------- 17:19:45 INFO - PROCESS | 17621 | Number of tests: 10 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 166.9 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#1] DeltaBlue Cycles:1 Average:191.02 Median:191.02 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 191.0 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 279.6 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 5175.3 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 1075.3 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#5] Earley Cycles:1 Average:705.22 Median:705.22 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 705.2 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 12168.7 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 26000.0 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#8] Splay Cycles:1 Average:677.51 Median:677.51 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 677.5 17:19:45 INFO - PROCESS | 17621 | 17:19:45 INFO - PROCESS | 17621 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:19:45 INFO - PROCESS | 17621 | Values: 4845.4 17:19:45 INFO - PROCESS | 17621 | -------- Summary: end -------- 17:19:45 INFO - PROCESS | 17621 | 17:19:46 INFO - TEST-INFO | 17621: exit 0 17:19:46 INFO - TEST-OK | v8_7 | took 40259ms 17:19:46 INFO - SUITE-END | took 1212s 17:19:46 INFO - Completed test suite (00:20:12) 17:19:46 INFO - Working with test: dromaeo_css 17:19:46 INFO - Generating results file: dromaeo_css 17:19:46 INFO - Working with test: kraken 17:19:46 INFO - Generating results file: kraken 17:19:46 INFO - javascript benchmark 17:19:46 INFO - Working with test: v8_7 17:19:46 INFO - Generating results file: v8_7 17:19:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:19:46 INFO - process_Request line: dromaeo_css 6802.18 graph.html#tests=[[72,64,43]] 17:19:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:46 INFO - process_Request line: kraken 1525.80 graph.html#tests=[[232,64,43]] 17:19:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:46 INFO - process_Request line: v8_7 21060.14 graph.html#tests=[[230,64,43]] 17:19:46 INFO - RETURN: dromaeo_css: 6802.18 17:19:46 INFO - RETURN: kraken: 1525.80 17:19:46 INFO - RETURN: v8_7: 21060.14 17:19:46 INFO - javascript benchmark 17:19:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3174.2857856982178, 3223.161977885749, 3244.707976282137, 3264.9183770405743, 3267.738580913527, 5244.5542128919, 5470.535004524615, 5481.616286859921, 5490.615656904019, 5497.780088796453, 5380.677159370441, 5436.565074794017, 5495.697736624484, 5522.861928451791, 5556.194351818994, 4866.926996095061, 4954.603631709455, 4972.279019542164, 5009.298698182258, 5086.262491938666, 4947.529984651453, 4997.50024997501, 5033.874153146164, 5045.268436076767, 5050.166722490784, 4821.421429428474, 4897.3143759873465, 4913.091078150554, 5032.245163225545, 5039.21892106724, 4962.578180854632, 4999.575036121934, 5011.198208286693, 5023.547880690719, 5074.594032477393, 4801.975990120062, 4974.726390048546, 4984.327115839352, 5006.674566153189, 5069.493050694938, 5238.607104467142, 5275.657082289639, 5284.762185701653, 5295.735213239323, 5339.172428273624, 5857.238558987347, 5867.11993201019, 5870.501007414375, 5883.0881213411985, 5885.117232415129, 5750.5687073469235, 5899.203607512974, 5900.881982360329, 5902.61632993854, 5914.497267732248, 5391.0, 5434.592405569559, 5455.18172274158, 5460.645058071213, 5497.175423686439, 5988.401159883977, 5994.580379373489, 5999.610025348426, 6004.579679422399, 6006.6696331701305, 5683.2895888014, 5764.971175144181, 5765.279340082489, 5769.8557536061935, 5785.1611516329895, 5701.2018317435595, 5780.306363236438, 5781.219535362672, 5784.681842498619, 5792.478676919098, 5725.914111288334, 5734.5125664319, 5744.396838331999, 5778.219940308005, 5883.088121341113, 5876.324222714357, 5886.969780288432, 5899.793507227227, 5902.291724993029, 5919.0, 4492.249920102275, 4495.527969563149, 4509.6392288616835, 4528.886777830515, 4537.183307004705, 3942.0539070622845, 4019.5578486366476, 4036.455078564415, 4060.9847538115473, 4064.146529228895, 5415.079436495806, 5430.91853622196, 5456.61803673747, 5493.313335833021, 5533.059379905426, 5891.793787217427, 5892.469677729025, 5908.05471124618, 5929.762809487658, 5967.0, 5314.362276526842, 5422.457754224625, 5530.944690553123, 5533.667979921218, 5535.889282214333, 4959.355283813154, 5029.119904016782, 5034.521720436553, 5048.646594738407, 5072.873178170502, 6007.909881351783, 6016.578839481194, 6018.548608854353, 6029.8191054268445, 6030.125631783455, 5711.657300561979, 5818.272715910512, 5856.4143585641095, 5914.142449344907, 5933.0, 6095.801078121576, 6096.889554637438, 6099.3893660329, 6114.206128133634, 6119.897387362741, 5808.332041815076, 5847.152162936435, 5869.911951320819, 5870.090136028923, 5891.1752354669525, 5840.707964601838, 5879.7060146993335, 5927.051671732502, 5941.7623295067715, 5995.0, 5772.105323674838, 5816.621919575214, 5828.009238429392, 5834.562407819346, 5860.970695146497, 5720.3421606515785, 5799.884002319845, 5802.912956305743, 5805.419458054161, 5805.535557155333, 5564.19319198722, 5623.775048997994, 5649.7740090397565, 5653.2085508028085, 5734.455226753452, 5781.4507621775865, 5797.594168408171, 5826.359100499027, 5832.9792286348875, 5869.325027621878, 5659.773609055592, 5717.885642287048, 5741.483266506035, 5754.2519472469985, 5755.223044889054], "unit": "score", "name": "dojo.html", "value": 5404.871377882339}, {"lowerIsBetter": false, "replicates": [549.8625343664085, 552.6683989606234, 559.8997968990933, 567.4609121334734, 596.0582279997601, 38208.426873596916, 38906.416403753894, 39010.0, 39056.80471597642, 39069.0, 42787.0, 43470.34794478086, 43519.56480435203, 43524.56475435245, 43637.56362436375, 8692.826143477143, 8821.294296456268, 8861.601227944726, 8883.24492418142, 8895.377323587352, 8605.870911936327, 8663.350248731338, 8732.08313127122, 8743.256823170006, 8749.431286966359, 8590.656373745043, 8591.226789588936, 8632.525211113387, 8653.870191947126, 8687.218150366465, 8707.738767836974, 8740.956295218482, 8775.78060548485, 8795.648174073061, 8801.383903126783, 8524.744257672217, 8612.5693715314, 8634.654613815439, 8672.696455624024, 8700.086490918426, 38495.807520962495, 38538.61461385378, 38706.41940370897, 38720.0, 38987.415188771905, 2691.232998595391, 3155.3216058547523, 3541.6812486876047, 4029.5567487576345, 4067.1458993611377, 27152.592711109348, 27751.86124069387, 28111.0, 28374.0, 28430.147095587166, 3861.227754449121, 3892.649661530476, 3944.4280579316123, 3959.425883246942, 4012.353378469403, 215645.0, 216189.0, 216322.91838540864, 216701.0, 217794.0, 42432.0, 42896.0, 56146.0, 58582.0, 58938.41061589415, 52268.21597676038, 52268.738656307236, 52373.214401784004, 52561.7371913138, 52834.73582632062, 15323.387064517294, 15399.461018864286, 15519.068855868683, 15559.377624895104, 15571.76642350343, 11692.824607630891, 11860.22908510944, 11868.10989175798, 11872.287662740264, 11873.406329683654, 19344.226230950884, 19572.923489207944, 19616.0, 19618.411447656592, 19773.90113049454, 7761.107472640719, 7843.921560784319, 7955.880661790078, 7971.282584567417, 8079.272865442021, 882.3162049411757, 906.664534122379, 925.1765928323797, 1050.1965996012902, 1059.5761695321933, 27912.72087279101, 28424.43151137007, 28736.712632873823, 29022.709772902424, 29159.85420072886, 959.6641175588488, 983.9508024598741, 1007.5566750629699, 1053.9894601054045, 1122.680036189682, 12989.0, 13754.85080954894, 13871.930640346936, 13893.79159312611, 14178.574642760734, 312229.0, 316577.0, 317278.0, 317492.0, 317711.0, 49986.750066249435, 50068.749656251486, 50625.24062139071, 50678.49321506811, 50718.0, 1311.6655252910637, 1312.0487646456243, 1313.9802902956271, 1326.529082175833, 1327.7909028380059, 27132.914683413233, 27961.720382795913, 28178.43643127167, 28264.0, 28417.0, 41036.58963410447, 41122.58877411188, 41186.38220426636, 41419.58580414157, 41444.37833432441, 184917.0, 186939.0, 186986.0, 187523.0, 187778.0, 28065.43869122647, 30905.227369315948, 30905.381892362475, 30907.84546077255, 30988.81650977089, 37149.628503714615, 38319.42520862134, 40277.597224027384, 40752.0, 40966.38550421806, 34065.31869362648, 34078.0, 34602.307953841286, 34724.82637586796, 34981.65018349784, 34008.65991340154, 34477.448514816395, 34832.30335393328, 35329.82335088308, 35420.64579354277, 33242.66398802614, 33879.830600847825, 34356.82821585876, 34396.48405273873, 34399.48400774041, 29217.0, 29480.262993425335, 31417.52873706942, 31675.683243167274, 32104.518432223067, 23042.884785575963, 23999.64000540028, 24164.275071747874, 24231.636525452486, 24449.266522004367], "unit": "score", "name": "ext.html", "value": 17649.49037578077}, {"lowerIsBetter": false, "replicates": [353.78065599328403, 358.66823188550603, 360.46470990579, 363.8999275199321, 364.4496809817177, 16399.83600163998, 17039.659206815857, 17414.303427862902, 17798.91100544497, 17961.101944902766, 10245.334053286531, 10519.63181288655, 15386.076835389884, 15515.0, 15566.066036037846, 4884.58481029112, 5123.180291153416, 5425.077736784737, 5453.972730136364, 5457.590680698943, 5399.62202645815, 5433.782648694048, 5438.8912221755545, 5440.591955603346, 5447.782088716466, 5155.7422128893595, 5198.2982297389935, 5287.814926477574, 5303.65526240795, 5389.757460914248, 5265.921011184835, 5267.209918512234, 5281.07581173297, 5282.260483532308, 5301.257823904656, 5010.89978200434, 5119.129747942859, 5134.255532947702, 5135.3837539495125, 5149.201873709543, 11189.49647265875, 11530.769384612344, 12237.449314780857, 12458.937705311506, 12479.625611231677, 1906.761654793151, 1959.6178745144703, 2037.246218899002, 2073.40907841266, 2211.535577528705, 9340.626374944994, 9910.355826871302, 11242.550297988071, 12293.815592766116, 12554.435050422753, 1719.1891257793598, 1761.0842361971831, 1783.545195975031, 1802.7025540785755, 1853.8331550160415, 53749.731251343495, 57692.0, 58730.412695872925, 59270.11094833581, 60325.39674603242, 9912.900870991341, 10001.549930253155, 10111.898881011242, 10179.796404071878, 10198.286119971679, 12944.546940857213, 12954.80567791484, 13032.283224422748, 13057.869421305855, 13070.607881763563, 7613.276738709814, 7697.576633285111, 7766.844663106819, 7775.533467991939, 7782.338501227459, 7592.772216833504, 7607.65765540552, 7664.693412263447, 7682.0397450318715, 7704.460687751804, 4263.317869140923, 4281.293586558183, 4304.4834619845815, 4319.654427645781, 4322.675799315064, 1780.8842425242317, 1794.425783749214, 1798.9190486428142, 1800.396867049553, 1804.7383129446157, 422.47612959929467, 423.1431351513149, 425.797746070614, 462.63220739512167, 859.6346552715071, 10553.736156595993, 11001.284916480403, 11012.669619911416, 11057.11543076552, 11190.32858028521, 431.98920026999576, 442.0650324563589, 444.43556683012395, 450.6417398168464, 455.49667617283086, 5783.392743761929, 5993.250843644544, 6001.909971350433, 6032.849178770566, 6110.7861224856915, 490262.0, 509089.0, 513035.0, 514277.0, 515232.0, 72542.63728681323, 75360.0, 76150.23849761543, 76173.0, 76292.23707762851, 505.25727181043806, 510.8084468324378, 513.8895137545446, 514.3185279504671, 517.503196930943, 9875.604975801174, 10144.797104058025, 10187.84718229242, 10218.233632477446, 10269.897301026895, 31026.534601980537, 31159.0, 31250.687493125686, 31973.0, 32374.0, 44711.0, 44848.0, 44970.325445119, 45799.542004579525, 46268.768656156506, 9657.792775903012, 9840.507974601098, 9857.556409961426, 9871.111599955751, 9873.062059104373, 11637.301761894314, 15725.764113538535, 16737.91631041837, 16878.24047917822, 17128.229229684446, 8925.241354484942, 9228.261739060994, 13303.135296205715, 13438.529651462542, 13511.391987360395, 9821.901780982098, 9994.350367226107, 10069.144122749649, 10106.797864042825, 10141.898581014095, 9653.758656033655, 9916.950415247878, 9952.502374881082, 10025.298229124182, 10413.84379234297, 14809.703805923606, 14964.850351496345, 15034.097954122788, 15340.0, 15414.69170616559, 13883.305834708022, 14005.719885602028, 14870.256487175815, 14946.850531494545, 15048.849511504744], "unit": "score", "name": "jquery.html", "value": 7738.0375235196625}, {"lowerIsBetter": false, "replicates": [1417.340936464544, 1456.8761655259302, 1604.9679006419872, 1754.3684273661472, 1777.857771378289, 6848.417884479825, 6905.68924398402, 7497.212792656775, 7750.0, 7786.26030527099, 7341.486095973284, 7345.779626611197, 7542.245775422455, 7543.547387156775, 7545.358644515209, 2279.555486680098, 2287.5310561334886, 2298.7011688480557, 2302.792748652621, 2310.145246258878, 2247.6291411917096, 2263.660450932365, 2275.8975846086882, 2276.8178545716305, 2290.358699564125, 2244.6633005049293, 2266.9319920402413, 2295.070496448941, 2299.7585253548386, 2316.061994892071, 2281.863088214696, 2284.9885750571225, 2306.8615883046987, 2315.2591170825344, 2315.386422598013, 2308.8499247548857, 2335.4511689752894, 2336.8597884127007, 2341.5433990371885, 2342.6486027095903, 7708.61456927157, 7863.13505514393, 7877.015373078365, 7880.172581878935, 7903.0, 4649.395578574798, 4723.07899959508, 4743.7628118594275, 4748.738819364934, 4750.406199225097, 3033.9848300758576, 3040.3767227718263, 3135.466970614978, 3144.0882144178163, 3176.6029246344206, 1020.9489525523768, 1032.6282538286212, 1035.7824856780085, 1045.2578669144916, 1969.1532640964379, 9759.365641233297, 9861.654842080565, 9889.456079915602, 9909.752256193653, 9911.108000279937, 4191.0, 4269.740426574168, 4317.827286908551, 4327.307630779123, 4373.693841431069, 9154.084591540926, 9177.944536378402, 9185.724428267162, 9197.172254497127, 9207.40151890125, 4798.328234047236, 4803.255495398219, 4808.3027960945465, 4813.4945830687975, 4825.276208568673, 4123.814428350732, 4191.308434108338, 4205.0959043805115, 4223.68322375823, 4341.479022517318, 3379.5606571145595, 3416.641252668484, 3426.0407086015957, 3432.952949350472, 3480.2343484433386, 1004.9497525123714, 1015.6140666546665, 1022.2741853284103, 1046.2310202001522, 1046.424466543398, 1035.8808736995343, 1040.812653722322, 1218.9146759726912, 1318.7889937609937, 1334.8665133486575, 7167.569945803164, 7191.173015103225, 7199.820004499929, 7296.7446139384865, 7509.812254693677, 456.04231114659615, 456.36337309453125, 459.2009902769158, 459.43718944292976, 473.24753641709844, 5716.571257155647, 5768.596198266165, 5774.422557744192, 5785.537157027427, 5792.333881603585, 8912.465252084896, 9079.636814527477, 9099.1810737034, 9141.085891410805, 9240.122188392092, 9114.0, 9147.359684821999, 9180.0, 9206.953965230265, 9272.072792720808, 7179.282071792779, 7241.529300595339, 7245.89131163033, 7262.927370726331, 7265.365292809076, 7162.7493037743425, 7200.0, 7206.315400036988, 7220.927790722026, 7224.855502890018, 8004.7198348059865, 8158.469699469515, 8224.465409748347, 8382.203690649378, 8401.32789376836, 8567.528785916835, 8590.699325523577, 8610.913890861262, 8627.0, 8648.43785153963, 6782.084418603426, 6859.382655561023, 6928.688209030706, 6951.860962780817, 7025.964870175617, 7270.0, 7288.744893928687, 7295.4528410368375, 7297.854042919006, 7297.854042919218, 6677.198736151498, 6867.175938887365, 6911.101556797584, 7023.859522809413, 7027.332403421667, 6789.083473730983, 6811.182658081062, 6875.828104297432, 6893.586384816927, 6942.8611427772175, 6429.196350456193, 6498.155239818982, 6713.060171576081, 6715.597064176165, 6772.966135169293, 6226.25284965807, 6239.251289845066, 6291.433770960635, 6297.275813281532, 6303.306636269915, 6288.119663247057, 6309.968450157719, 6338.049292606146, 6352.0, 6359.459445947146], "unit": "score", "name": "mootools.html", "value": 4351.851495576397}, {"lowerIsBetter": false, "replicates": [344.8172468591646, 351.497358776949, 354.35330521797715, 358.78652201939855, 360.70422253751934, 6120.2043734314475, 6263.467605253553, 6265.968670156649, 6283.465905398047, 6316.368363163687, 6059.454649081582, 6211.751529938809, 6215.564910456259, 6234.220722409699, 6248.750049997994, 4781.617470602343, 4792.496787837279, 4798.592119669815, 4819.34938783265, 4819.686720363183, 4776.665633405663, 4810.542998415145, 4822.252550854623, 4833.709977401367, 4833.854984350475, 4629.213033784265, 4738.549837765407, 4747.216709242988, 4762.0, 4771.117343291485, 4744.312074749177, 4754.429468463789, 4761.547652972962, 4763.14263432582, 4771.928421073687, 4009.8997525061814, 4101.4668093148, 4167.1457351242925, 4192.706510544263, 4201.432806571104, 5884.6469211847425, 5911.172435858984, 5911.349751527328, 5919.4080591940465, 5929.733162007677, 5512.118061110203, 5514.062609356419, 5514.0901751211, 5516.310461192351, 5524.171374293848, 6500.544961852672, 6572.572782769104, 6600.339966003409, 6615.702293396808, 6616.93383066168, 4551.340055691906, 4552.066826300634, 4553.840615578439, 4556.951901062774, 4558.908821823578, 6877.552959057645, 6910.3089691031, 6927.653617319113, 6931.757388491378, 6937.236903940562, 4672.392588963413, 4677.695949763254, 4682.555157260055, 4689.085628302449, 4690.507496712796, 4650.0, 4738.73936933465, 4741.857744267678, 4747.786349614275, 4751.572358487683, 5487.341519017664, 5489.3687225969525, 5493.752781124859, 5498.065328894098, 5505.587080968943, 6583.967080164664, 6627.701753421107, 6634.7393995140765, 6637.668116594151, 6637.767678131242, 1662.4430815676642, 1686.3170415981547, 1693.09419460588, 1695.059242120635, 1695.796504419453, 1063.1016790811752, 1094.5020015892749, 1104.1939384249383, 1114.587602587048, 1122.180808010157, 6304.338044505353, 6315.715792789244, 6317.178766760292, 6317.210348706411, 6324.9051264231075, 6818.829529261709, 6833.658317084126, 6839.350261725128, 6856.211535673362, 6872.140982377203, 6210.192674952227, 6213.378662133841, 6281.0, 6317.684115794192, 6319.810405687745, 3711.3690672585726, 3712.461693054492, 3719.237556300952, 3726.142987112979, 3733.1600389912596, 6917.377436030782, 7111.431085513146, 7139.785806425815, 7146.785596432115, 7150.928490715026, 7072.9646351767915, 7095.716171353191, 7101.325374089453, 7109.857802843914, 7112.35988761014, 7043.2604576518725, 7157.856842863218, 7163.606001669854, 7171.354578087893, 7177.3899218567, 6778.898316525355, 6799.354061364163, 6823.522353435212, 6826.522143449911, 6840.828979275558, 6760.830979225559, 6775.728970841308, 6793.150856142982, 6812.25065242813, 6832.3850853421445, 7003.894941575983, 7087.681054352463, 7095.148582170173, 7170.175429825428, 7189.2810718927685, 4594.402727645384, 4652.883677908079, 4655.511171326962, 4665.32352808834, 4668.696534725232, 6886.311368863274, 6890.449648829174, 6891.827704307432, 6903.206131294965, 6903.378695917391, 6568.27748947625, 6589.143411356493, 6634.237062737654, 6638.800835974928, 6705.430038446787, 6678.3989440950545, 6711.161104861892, 6711.6308603025345, 6712.93287067123, 6725.092112564741, 6507.869842603216, 6572.441342485942, 6577.868442631217, 6601.33986601336, 6603.834904127435, 6590.014584540211, 6709.698063587248, 6732.596044237362, 6739.528233023641, 6748.0, 6581.967090164519, 6584.835379115369, 6589.934100658932, 6592.307807680317, 6597.472202223907], "unit": "score", "name": "prototype.html", "value": 5001.831336854825}, {"lowerIsBetter": false, "replicates": [816.0778320497836, 821.4373154389244, 837.7989282572182, 837.9371547133965, 856.3962406503416, 12907.548235811748, 13067.93466032671, 13077.953763698904, 13080.738385232302, 13088.476460941574, 11391.430428478563, 12295.0, 12331.630051098482, 12373.257604543734, 12398.628041158758, 644.9451796597283, 802.0896282719098, 815.2784785464847, 819.3035919468434, 819.9590020498981, 787.6140691061368, 788.6845261895259, 799.4284086877881, 800.7077416742906, 802.8394321135767, 845.0155568762384, 853.8932633420823, 856.2422256303154, 856.7044369692477, 858.6737039924851, 838.5849004742661, 844.4215712237137, 847.0089994706148, 850.9574521273943, 852.47146769003, 612.1796792298297, 615.2924137242162, 621.2575971713803, 621.2793159934499, 621.636342739498, 12322.383880805924, 12334.691632709164, 12424.75150496994, 12430.937845310806, 12434.191777534521, 12248.448819803041, 12397.194182378116, 12600.684982875502, 12874.935625321814, 12939.223646581235, 9535.141837234612, 9764.462954537497, 9871.160951319147, 10031.949840250825, 10057.748556286151, 3539.07983924179, 3580.5703315602036, 3598.676119149289, 3635.0, 3704.203596226824, 46053.0, 46150.53849461496, 46152.76923615394, 46289.07421851578, 46340.768296158305, 9742.707718768306, 9742.805143897082, 9955.950220248853, 9993.600255989824, 10004.749881253027, 18158.45524634263, 18166.18252178655, 18214.45356639303, 18258.26966921308, 18265.086745662662, 6940.119404169252, 7100.0, 7172.784816455514, 7181.35367816899, 7273.6726847292, 4176.937345939813, 4202.894927626834, 4213.747175169438, 4253.21315556623, 4265.893352666209, 3060.3726236121543, 3080.8151510909415, 3101.8138911665374, 3102.720755132049, 3106.891258805931, 571.0520535910368, 572.0846645367462, 577.8353169346716, 582.0251079441917, 601.3265143039823, 538.2088330154745, 560.5655616896937, 571.5998800839429, 651.4462706699268, 659.2418718473698, 7394.334509894135, 7905.095285956927, 8159.632816523152, 8286.254237118688, 8480.957595212109, 574.2850151561333, 622.1103821535248, 642.1619786178987, 642.9164208652845, 672.5561129654404, 3963.7819919904105, 4058.0, 4205.179989902001, 4353.804078816461, 4370.475542934804, 52126.0, 52195.73902130465, 52315.215271770954, 52606.736966315686, 53271.73364133154, 48539.51460485421, 48684.75657621689, 49229.261561076615, 49859.25211121836, 49901.0, 42974.570254297054, 43246.78376608097, 43676.126477470905, 43746.56253437488, 44141.7792911027, 8717.782055448664, 8872.245859101791, 8889.377743558147, 8904.599293031699, 9004.954975225082, 32474.675253247166, 32898.17754556155, 32963.835180823946, 33370.83314583411, 33793.49309760307, 38458.42312365373, 38824.0, 39242.2151556973, 43358.78320608377, 43690.90772730707, 10639.308444951053, 10835.945820271163, 10866.891331086588, 10908.836367454336, 10932.672019839418, 12278.631641050782, 12406.0, 12939.935300323437, 12986.35068246565, 13002.349882505649, 9949.950250248703, 10534.473276335999, 10993.0, 11009.61466348674, 11017.44912754375, 11156.888431115585, 11297.774044519228, 11305.321680699184, 11424.657260282205, 11711.824322634997, 9356.578953946953, 10991.780164396507, 11089.94455027752, 11447.084233261485, 11575.247608905394, 9875.111239988435, 9891.35706179096, 9933.304668673123, 10210.030047145508, 10341.069303762697, 8588.355873309401, 9063.773405664911, 9711.9028809711, 9752.0, 9790.608375664893], "unit": "score", "name": "yui.html", "value": 6164.539264664987}], "name": "dromaeo_css", "value": 6802.175942601825}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 113.0, 111.0, 112.0, 123.0, 112.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 151.0, 164.0, 134.0, 155.0, 160.0, 129.0, 173.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 165.0, 162.0, 161.0, 163.0, 167.0, 170.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 74.0, 74.0, 71.0, 74.0, 72.0, 140.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 97.0, 97.0, 97.0, 140.0, 96.0, 97.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 146.0, 147.0, 148.0, 147.0, 147.0, 150.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 101.0, 99.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 60.0, 58.0, 61.0, 59.0, 59.0, 69.0, 57.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 86.0, 87.0, 87.0, 86.0, 90.0, 87.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 130.0, 125.0, 121.0, 120.0, 121.0, 122.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [150.0, 145.0, 162.0, 151.0, 145.0, 142.0, 154.0, 153.0, 153.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 73.0, 68.0, 68.0, 69.0, 71.0, 70.0, 80.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1525.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [191.0219675262655], "unit": "score", "name": "DeltaBlue", "value": 346.12773000000004}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [705.2186177715091], "unit": "score", "name": "Earley", "value": 945.0445340000002}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [677.5067750677507], "unit": "score", "name": "Splay", "value": 120.28071599999996}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21060.14456546148}]} 17:19:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21060.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1525.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6802.18"}}} 17:19:47 INFO - Return code: 0 17:19:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:19:47 INFO - # TBPL SUCCESS # 17:19:47 INFO - Running post-action listener: _resource_record_post_action 17:19:47 INFO - Running post-run listener: _resource_record_post_run 17:19:48 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 553312256; Read time: 0; Write time: 470044 17:19:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235171840; Read time: 0; Write time: 307752 17:19:48 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 318140416; Read time: 0; Write time: 162292 17:19:48 INFO - Running post-run listener: _upload_blobber_files 17:19:48 INFO - Blob upload gear active. 17:19:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:19:48 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 17:19:48 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'] 17:19:48 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 17:19:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:49 INFO - (blobuploader) - INFO - Done attempting. 17:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:50 INFO - (blobuploader) - INFO - Done attempting. 17:19:50 INFO - (blobuploader) - INFO - Iteration through files over. 17:19:50 INFO - Return code: 0 17:19:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:19:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:19:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d61d4af7fbbac080c775be558ac66c3a1426a1e1223b4272cf9bc5d36a3c1a361247286079dbe2fee2231e074d43dd476efd968b70d65734ce692fde5db9959", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b59bcb60a78c0c09cd5fb53b5325cd0e619eabc19338e366e98d3eacf06887ba06d2e1d8e399617c4a249dc04ab2191970b556a857920830cf477e90c4c63bf6"} 17:19:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:19:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:19:50 INFO - Contents: 17:19:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d61d4af7fbbac080c775be558ac66c3a1426a1e1223b4272cf9bc5d36a3c1a361247286079dbe2fee2231e074d43dd476efd968b70d65734ce692fde5db9959", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b59bcb60a78c0c09cd5fb53b5325cd0e619eabc19338e366e98d3eacf06887ba06d2e1d8e399617c4a249dc04ab2191970b556a857920830cf477e90c4c63bf6"} 17:19:50 INFO - Copying logs to upload dir... 17:19:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.102441 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-04 17:19:50.236497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:50.239850) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d61d4af7fbbac080c775be558ac66c3a1426a1e1223b4272cf9bc5d36a3c1a361247286079dbe2fee2231e074d43dd476efd968b70d65734ce692fde5db9959", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b59bcb60a78c0c09cd5fb53b5325cd0e619eabc19338e366e98d3eacf06887ba06d2e1d8e399617c4a249dc04ab2191970b556a857920830cf477e90c4c63bf6"} build_url:https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d61d4af7fbbac080c775be558ac66c3a1426a1e1223b4272cf9bc5d36a3c1a361247286079dbe2fee2231e074d43dd476efd968b70d65734ce692fde5db9959", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b59bcb60a78c0c09cd5fb53b5325cd0e619eabc19338e366e98d3eacf06887ba06d2e1d8e399617c4a249dc04ab2191970b556a857920830cf477e90c4c63bf6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:50.266969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:50.267411) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1451955355.364093-496888601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:50.354280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:19:50.354853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:19:50.355437) ========= ========= Total master_lag: 0.23 =========