builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1451631147.01 results: success (0) buildid: 20151231203134 builduid: 43a06c854c9a476f9eaffbac138a5a74 revision: 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.013088) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.014255) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.014772) ========= 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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006388 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.077801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.078194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.165316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.165667) ========= 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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.222732) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.223090) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.223525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.223864) ========= 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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 22:52:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-12-31 22:52:27 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200164 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.442869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.443241) ========= 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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015754 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.493163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.493544) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 --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 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 --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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 22:52:27,786 truncating revision to first 12 chars 2015-12-31 22:52:27,786 Setting DEBUG logging. 2015-12-31 22:52:27,786 attempt 1/10 2015-12-31 22:52:27,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30c5cd7a3ec7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 22:52:28,013 unpacking tar archive at: fx-team-30c5cd7a3ec7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.483416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.989871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.990192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.998761) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.999070) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.999511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 42 secs) (at 2015-12-31 22:52:27.999841) ========= /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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:52:28 INFO - MultiFileLogger online at 20151231 22:52:28 in /builds/slave/test-pgo 22:52:28 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 22:52:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:52:28 INFO - {'append_to_log': False, 22:52:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:52:28 INFO - 'blob_upload_branch': 'Fx-Team', 22:52:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:52:28 INFO - 'branch': 'Fx-Team', 22:52:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:52:28 INFO - 'config_files': ('talos/linux_config.py',), 22:52:28 INFO - 'default_actions': ('clobber', 22:52:28 INFO - 'read-buildbot-config', 22:52:28 INFO - 'download-and-extract', 22:52:28 INFO - 'populate-webroot', 22:52:28 INFO - 'create-virtualenv', 22:52:28 INFO - 'install', 22:52:28 INFO - 'run-tests'), 22:52:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:52:28 INFO - 'download_minidump_stackwalk': True, 22:52:28 INFO - 'download_symbols': 'ondemand', 22:52:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:52:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:52:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:52:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:52:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:52:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:52:28 INFO - 'installer_path': 'installer.exe', 22:52:28 INFO - 'log_level': 'info', 22:52:28 INFO - 'log_name': 'talos', 22:52:28 INFO - 'log_to_console': True, 22:52:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:52:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:52:28 INFO - 'opt_config_files': (), 22:52:28 INFO - 'pip_index': False, 22:52:28 INFO - 'sps_profile': False, 22:52:28 INFO - 'sps_profile_interval': 0, 22:52:28 INFO - 'suite': 'dromaeojs-e10s', 22:52:28 INFO - 'system_bits': '32', 22:52:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:52:28 INFO - 'title': 'talos-linux64-ix-013', 22:52:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:52:28 INFO - 'use_talos_json': True, 22:52:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:52:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:52:28 INFO - 'work_dir': 'build'} 22:52:28 INFO - ##### 22:52:28 INFO - ##### Running clobber step. 22:52:28 INFO - ##### 22:52:28 INFO - Running pre-action listener: _resource_record_pre_action 22:52:28 INFO - Running main action method: clobber 22:52:28 INFO - rmtree: /builds/slave/test-pgo/build 22:52:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:52:29 INFO - Running post-action listener: _resource_record_post_action 22:52:29 INFO - ##### 22:52:29 INFO - ##### Running read-buildbot-config step. 22:52:29 INFO - ##### 22:52:29 INFO - Running pre-action listener: _resource_record_pre_action 22:52:29 INFO - Running main action method: read_buildbot_config 22:52:29 INFO - Using buildbot properties: 22:52:29 INFO - { 22:52:29 INFO - "project": "", 22:52:29 INFO - "product": "firefox", 22:52:29 INFO - "script_repo_revision": "production", 22:52:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:52:29 INFO - "repository": "", 22:52:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:52:29 INFO - "buildid": "20151231203134", 22:52:29 INFO - "pgo_build": "True", 22:52:29 INFO - "basedir": "/builds/slave/test-pgo", 22:52:29 INFO - "buildnumber": 420, 22:52:29 INFO - "slavename": "talos-linux64-ix-013", 22:52:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:52:29 INFO - "platform": "ubuntu64_hw", 22:52:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:52:29 INFO - "branch": "fx-team", 22:52:29 INFO - "repo_path": "integration/fx-team", 22:52:29 INFO - "revision": "30c5cd7a3ec750909be74cc68473a6e30ee7f6e6", 22:52:29 INFO - "stage_platform": "linux64-pgo", 22:52:29 INFO - "builduid": "43a06c854c9a476f9eaffbac138a5a74", 22:52:29 INFO - "slavebuilddir": "test" 22:52:29 INFO - } 22:52:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:52:29 INFO - Running post-action listener: _resource_record_post_action 22:52:29 INFO - ##### 22:52:29 INFO - ##### Running download-and-extract step. 22:52:29 INFO - ##### 22:52:29 INFO - Running pre-action listener: _resource_record_pre_action 22:52:29 INFO - Running main action method: download_and_extract 22:52:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:29 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:52:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json 22:52:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json 22:52:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:52:34 INFO - Downloaded 1302 bytes. 22:52:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:52:34 INFO - Using the following test package requirements: 22:52:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:52:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:34 INFO - u'jsshell-linux-x86_64.zip'], 22:52:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:52:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:52:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:52:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:52:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:52:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:52:34 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')]} 22:52:34 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:35 INFO - Downloaded 23195377 bytes. 22:52:35 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 22:52:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:35 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 22:52:36 INFO - Return code: 0 22:52:36 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 22:52:36 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')]} 22:52:36 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:37 INFO - Downloaded 23195377 bytes. 22:52:37 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 22:52:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:37 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 22:52:38 INFO - Return code: 0 22:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:38 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:42 INFO - Downloaded 11132285 bytes. 22:52:42 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 22:52:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:42 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 22:52:43 INFO - Return code: 0 22:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:43 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:44 INFO - Downloaded 54935246 bytes. 22:52:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:44 INFO - mkdir: /builds/slave/test-pgo/properties 22:52:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:52:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:52:44 INFO - Contents: 22:52:44 INFO - build_url:https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:44 INFO - Running post-action listener: _resource_record_post_action 22:52:44 INFO - Running post-action listener: set_extra_try_arguments 22:52:44 INFO - ##### 22:52:44 INFO - ##### Running populate-webroot step. 22:52:44 INFO - ##### 22:52:44 INFO - Running pre-action listener: _resource_record_pre_action 22:52:44 INFO - Running main action method: populate_webroot 22:52:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:52:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:52:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:52:44 INFO - '--tppagecycles', 22:52:44 INFO - '7'], 22:52:44 INFO - 'tests': ['tsvgm']}}, 22:52:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:52:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:52:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:52:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:52:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'tests': ['damp', 'tps']}, 22:52:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['damp', 'tps']}, 22:52:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:52:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:52:44 INFO - 'other': {'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other_l64': {'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other_nol64': {'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'svgr': {'tests': ['tsvgx', 22:52:44 INFO - 'tsvgr_opacity', 22:52:44 INFO - 'tart', 22:52:44 INFO - 'tscrollx', 22:52:44 INFO - 'cart']}, 22:52:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tsvgx', 22:52:44 INFO - 'tsvgr_opacity', 22:52:44 INFO - 'tart', 22:52:44 INFO - 'tscrollx', 22:52:44 INFO - 'cart']}, 22:52:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'tests': ['tp5o']}, 22:52:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tp5o']}, 22:52:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--xperf_path', 22:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:44 INFO - 'tests': ['tp5n']}, 22:52:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s', 22:52:44 INFO - '--xperf_path', 22:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:44 INFO - 'tests': ['tp5n']}}, 22:52:44 INFO - 'talos.zip': {'path': '', 22:52:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:52:44 INFO - Running post-action listener: _resource_record_post_action 22:52:44 INFO - ##### 22:52:44 INFO - ##### Running create-virtualenv step. 22:52:44 INFO - ##### 22:52:44 INFO - Running pre-action listener: _resource_record_pre_action 22:52:44 INFO - Running main action method: create_virtualenv 22:52:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:52:44 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 22:52:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:52:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:52:44 INFO - Using real prefix '/usr' 22:52:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:52:44 INFO - Installing distribute.............................................................................................................................................................................................done. 22:52:46 INFO - Installing pip.................done. 22:52:46 INFO - Return code: 0 22:52:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:52:46 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')]} 22:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:46 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')]} 22:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:46 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 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:52:46 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 22:52:46 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 22:52:46 INFO - Using env: {'DISPLAY': ':0', 22:52:46 INFO - 'HOME': '/home/cltbld', 22:52:46 INFO - 'LANG': 'en_US.UTF-8', 22:52:46 INFO - 'LANGUAGE': 'en_US:en', 22:52:46 INFO - 'LOGNAME': 'cltbld', 22:52:46 INFO - 'MAIL': '/var/mail/cltbld', 22:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:46 INFO - 'MOZ_NO_REMOTE': '1', 22:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:46 INFO - 'NO_EM_RESTART': '1', 22:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:46 INFO - 'SHELL': '/bin/bash', 22:52:46 INFO - 'SHLVL': '1', 22:52:46 INFO - 'TERM': 'linux', 22:52:46 INFO - 'TMOUT': '86400', 22:52:46 INFO - 'USER': 'cltbld', 22:52:46 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:46 INFO - '_': '/tools/buildbot/bin/python'} 22:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:47 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 22:52:47 INFO - Cleaning up... 22:52:47 INFO - Return code: 0 22:52:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:52:47 INFO - Using env: {'DISPLAY': ':0', 22:52:47 INFO - 'HOME': '/home/cltbld', 22:52:47 INFO - 'LANG': 'en_US.UTF-8', 22:52:47 INFO - 'LANGUAGE': 'en_US:en', 22:52:47 INFO - 'LOGNAME': 'cltbld', 22:52:47 INFO - 'MAIL': '/var/mail/cltbld', 22:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:47 INFO - 'MOZ_NO_REMOTE': '1', 22:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:47 INFO - 'NO_EM_RESTART': '1', 22:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:47 INFO - 'SHELL': '/bin/bash', 22:52:47 INFO - 'SHLVL': '1', 22:52:47 INFO - 'TERM': 'linux', 22:52:47 INFO - 'TMOUT': '86400', 22:52:47 INFO - 'USER': 'cltbld', 22:52:47 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:47 INFO - '_': '/tools/buildbot/bin/python'} 22:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:47 INFO - Downloading/unpacking psutil>=0.7.1 22:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:52:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:49 INFO - Installing collected packages: psutil 22:52:49 INFO - Running setup.py install for psutil 22:52:49 INFO - building 'psutil._psutil_linux' extension 22:52:49 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 22:52:49 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 22:52:49 INFO - building 'psutil._psutil_posix' extension 22:52:49 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 22:52:49 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 22:52:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:49 INFO - Successfully installed psutil 22:52:49 INFO - Cleaning up... 22:52:50 INFO - Return code: 0 22:52:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:52:50 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')]} 22:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:50 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')]} 22:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:50 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 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:52:50 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 22:52:50 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 22:52:50 INFO - Using env: {'DISPLAY': ':0', 22:52:50 INFO - 'HOME': '/home/cltbld', 22:52:50 INFO - 'LANG': 'en_US.UTF-8', 22:52:50 INFO - 'LANGUAGE': 'en_US:en', 22:52:50 INFO - 'LOGNAME': 'cltbld', 22:52:50 INFO - 'MAIL': '/var/mail/cltbld', 22:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:50 INFO - 'MOZ_NO_REMOTE': '1', 22:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:50 INFO - 'NO_EM_RESTART': '1', 22:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:50 INFO - 'SHELL': '/bin/bash', 22:52:50 INFO - 'SHLVL': '1', 22:52:50 INFO - 'TERM': 'linux', 22:52:50 INFO - 'TMOUT': '86400', 22:52:50 INFO - 'USER': 'cltbld', 22:52:50 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:50 INFO - '_': '/tools/buildbot/bin/python'} 22:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:52:51 INFO - Installing collected packages: mozsystemmonitor 22:52:51 INFO - Running setup.py install for mozsystemmonitor 22:52:52 INFO - Successfully installed mozsystemmonitor 22:52:52 INFO - Cleaning up... 22:52:52 INFO - Return code: 0 22:52:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:52:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:52:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:52:52 INFO - Using env: {'DISPLAY': ':0', 22:52:52 INFO - 'HOME': '/home/cltbld', 22:52:52 INFO - 'LANG': 'en_US.UTF-8', 22:52:52 INFO - 'LANGUAGE': 'en_US:en', 22:52:52 INFO - 'LOGNAME': 'cltbld', 22:52:52 INFO - 'MAIL': '/var/mail/cltbld', 22:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:52 INFO - 'MOZ_NO_REMOTE': '1', 22:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:52 INFO - 'NO_EM_RESTART': '1', 22:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:52 INFO - 'SHELL': '/bin/bash', 22:52:52 INFO - 'SHLVL': '1', 22:52:52 INFO - 'TERM': 'linux', 22:52:52 INFO - 'TMOUT': '86400', 22:52:52 INFO - 'USER': 'cltbld', 22:52:52 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:52 INFO - '_': '/tools/buildbot/bin/python'} 22:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:53 INFO - Downloading blobuploader-1.2.4.tar.gz 22:52:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:52:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - Downloading docopt-0.6.1.tar.gz 22:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:52:54 INFO - Installing collected packages: blobuploader, requests, docopt 22:52:54 INFO - Running setup.py install for blobuploader 22:52:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:52:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:52:54 INFO - Running setup.py install for requests 22:52:55 INFO - Running setup.py install for docopt 22:52:55 INFO - Successfully installed blobuploader requests docopt 22:52:55 INFO - Cleaning up... 22:52:55 INFO - Return code: 0 22:52:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:55 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 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:52:55 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 22:52:55 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 22:52:55 INFO - Using env: {'DISPLAY': ':0', 22:52:55 INFO - 'HOME': '/home/cltbld', 22:52:55 INFO - 'LANG': 'en_US.UTF-8', 22:52:55 INFO - 'LANGUAGE': 'en_US:en', 22:52:55 INFO - 'LOGNAME': 'cltbld', 22:52:55 INFO - 'MAIL': '/var/mail/cltbld', 22:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:55 INFO - 'MOZ_NO_REMOTE': '1', 22:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:55 INFO - 'NO_EM_RESTART': '1', 22:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:55 INFO - 'SHELL': '/bin/bash', 22:52:55 INFO - 'SHLVL': '1', 22:52:55 INFO - 'TERM': 'linux', 22:52:55 INFO - 'TMOUT': '86400', 22:52:55 INFO - 'USER': 'cltbld', 22:52:55 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:55 INFO - '_': '/tools/buildbot/bin/python'} 22:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:55 INFO - Running setup.py (path:/tmp/pip-ueeboI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:55 INFO - Running setup.py (path:/tmp/pip-5vkHS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:55 INFO - Running setup.py (path:/tmp/pip-HdXl2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:55 INFO - Running setup.py (path:/tmp/pip-624bPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:55 INFO - Running setup.py (path:/tmp/pip-ukKpx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:55 INFO - Running setup.py (path:/tmp/pip-MNxidB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:55 INFO - Running setup.py (path:/tmp/pip-CV3vcy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:55 INFO - Running setup.py (path:/tmp/pip-je9q4T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:56 INFO - Running setup.py (path:/tmp/pip-rBKFa0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:56 INFO - Running setup.py (path:/tmp/pip-GNeVli-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:56 INFO - Running setup.py (path:/tmp/pip-65UA0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:52:56 INFO - Running setup.py (path:/tmp/pip-l_0T58-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:52:56 INFO - Running setup.py (path:/tmp/pip-pQ_9eT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:52:56 INFO - Running setup.py (path:/tmp/pip-bVf2HD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:52:56 INFO - Running setup.py (path:/tmp/pip-nRBK9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:52:56 INFO - Running setup.py (path:/tmp/pip-NjsnhO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:52:56 INFO - Running setup.py (path:/tmp/pip-GfrKJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:52:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:52:56 INFO - Running setup.py install for manifestparser 22:52:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:52:56 INFO - Running setup.py install for mozcrash 22:52:56 INFO - Running setup.py install for mozdebug 22:52:57 INFO - Running setup.py install for mozdevice 22:52:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozfile 22:52:57 INFO - Running setup.py install for mozhttpd 22:52:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozinfo 22:52:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozInstall 22:52:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozleak 22:52:57 INFO - Running setup.py install for mozlog 22:52:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for moznetwork 22:52:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozprocess 22:52:57 INFO - Running setup.py install for mozprofile 22:52:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Running setup.py install for mozrunner 22:52:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Running setup.py install for mozscreenshot 22:52:58 INFO - Running setup.py install for moztest 22:52:58 INFO - Running setup.py install for mozversion 22:52:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:52:58 INFO - Cleaning up... 22:52:58 INFO - Return code: 0 22:52:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:58 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 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:52:58 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 22:52:58 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 22:52:58 INFO - Using env: {'DISPLAY': ':0', 22:52:58 INFO - 'HOME': '/home/cltbld', 22:52:58 INFO - 'LANG': 'en_US.UTF-8', 22:52:58 INFO - 'LANGUAGE': 'en_US:en', 22:52:58 INFO - 'LOGNAME': 'cltbld', 22:52:58 INFO - 'MAIL': '/var/mail/cltbld', 22:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:58 INFO - 'MOZ_NO_REMOTE': '1', 22:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:58 INFO - 'NO_EM_RESTART': '1', 22:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:58 INFO - 'SHELL': '/bin/bash', 22:52:58 INFO - 'SHLVL': '1', 22:52:58 INFO - 'TERM': 'linux', 22:52:58 INFO - 'TMOUT': '86400', 22:52:58 INFO - 'USER': 'cltbld', 22:52:58 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:58 INFO - '_': '/tools/buildbot/bin/python'} 22:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:58 INFO - Running setup.py (path:/tmp/pip-HKJZ96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:58 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)) 22:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:58 INFO - Running setup.py (path:/tmp/pip-rpJyLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:58 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)) 22:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:58 INFO - Running setup.py (path:/tmp/pip-hksThX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:58 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)) 22:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:58 INFO - Running setup.py (path:/tmp/pip-dkJxKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:58 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:59 INFO - Running setup.py (path:/tmp/pip-PjXrrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:59 INFO - Running setup.py (path:/tmp/pip-Lh5nju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:59 INFO - Running setup.py (path:/tmp/pip-_PPsdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:59 INFO - Running setup.py (path:/tmp/pip-JTBrO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:59 INFO - Running setup.py (path:/tmp/pip-rmi34k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:59 INFO - Running setup.py (path:/tmp/pip-7SoQPa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:59 INFO - Running setup.py (path:/tmp/pip-9xTIT0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:52:59 INFO - Running setup.py (path:/tmp/pip-AnEvew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:52:59 INFO - Running setup.py (path:/tmp/pip-DVSbL3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:52:59 INFO - Running setup.py (path:/tmp/pip-6BGVUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:52:59 INFO - Running setup.py (path:/tmp/pip-M4iGPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:52:59 INFO - Running setup.py (path:/tmp/pip-ecmDtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:52:59 INFO - Running setup.py (path:/tmp/pip-T0Ok0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:52:59 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)) 22:52:59 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)) 22:52:59 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)) 22:52:59 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)) 22:52:59 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)) 22:52:59 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)) 22:52:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:52: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 22:52: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 22:52: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 22:52: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 22:52: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 22:52: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 22:53:01 INFO - Downloading blessings-1.5.1.tar.gz 22:53:01 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 22:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:53:01 INFO - Installing collected packages: blessings 22:53:01 INFO - Running setup.py install for blessings 22:53:01 INFO - Successfully installed blessings 22:53:01 INFO - Cleaning up... 22:53:01 INFO - Return code: 0 22:53:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:53:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:53:02 INFO - Reading from file tmpfile_stdout 22:53:02 INFO - Current package versions: 22:53:02 INFO - argparse == 1.2.1 22:53:02 INFO - blessings == 1.5.1 22:53:02 INFO - blobuploader == 1.2.4 22:53:02 INFO - docopt == 0.6.1 22:53:02 INFO - manifestparser == 1.1 22:53:02 INFO - mozInstall == 1.12 22:53:02 INFO - mozcrash == 0.16 22:53:02 INFO - mozdebug == 0.1 22:53:02 INFO - mozdevice == 0.47 22:53:02 INFO - mozfile == 1.2 22:53:02 INFO - mozhttpd == 0.7 22:53:02 INFO - mozinfo == 0.9 22:53:02 INFO - mozleak == 0.1 22:53:02 INFO - mozlog == 3.1 22:53:02 INFO - moznetwork == 0.27 22:53:02 INFO - mozprocess == 0.22 22:53:02 INFO - mozprofile == 0.28 22:53:02 INFO - mozrunner == 6.11 22:53:02 INFO - mozscreenshot == 0.1 22:53:02 INFO - mozsystemmonitor == 0.0 22:53:02 INFO - moztest == 0.7 22:53:02 INFO - mozversion == 1.4 22:53:02 INFO - psutil == 3.1.1 22:53:02 INFO - requests == 1.2.3 22:53:02 INFO - wsgiref == 0.1.2 22:53:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:53:02 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 22:53:02 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 22:53:02 INFO - Using env: {'DISPLAY': ':0', 22:53:02 INFO - 'HOME': '/home/cltbld', 22:53:02 INFO - 'LANG': 'en_US.UTF-8', 22:53:02 INFO - 'LANGUAGE': 'en_US:en', 22:53:02 INFO - 'LOGNAME': 'cltbld', 22:53:02 INFO - 'MAIL': '/var/mail/cltbld', 22:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:02 INFO - 'MOZ_NO_REMOTE': '1', 22:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:02 INFO - 'NO_EM_RESTART': '1', 22:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:02 INFO - 'SHELL': '/bin/bash', 22:53:02 INFO - 'SHLVL': '1', 22:53:02 INFO - 'TERM': 'linux', 22:53:02 INFO - 'TMOUT': '86400', 22:53:02 INFO - 'USER': 'cltbld', 22:53:02 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:02 INFO - '_': '/tools/buildbot/bin/python'} 22:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 INFO - Cleaning up... 22:53:02 INFO - Return code: 0 22:53:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:53:02 INFO - Using env: {'DISPLAY': ':0', 22:53:02 INFO - 'HOME': '/home/cltbld', 22:53:02 INFO - 'LANG': 'en_US.UTF-8', 22:53:02 INFO - 'LANGUAGE': 'en_US:en', 22:53:02 INFO - 'LOGNAME': 'cltbld', 22:53:02 INFO - 'MAIL': '/var/mail/cltbld', 22:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:02 INFO - 'MOZ_NO_REMOTE': '1', 22:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:02 INFO - 'NO_EM_RESTART': '1', 22:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:02 INFO - 'SHELL': '/bin/bash', 22:53:02 INFO - 'SHLVL': '1', 22:53:02 INFO - 'TERM': 'linux', 22:53:02 INFO - 'TMOUT': '86400', 22:53:02 INFO - 'USER': 'cltbld', 22:53:02 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:02 INFO - '_': '/tools/buildbot/bin/python'} 22:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:02 INFO - Downloading/unpacking jsonschema 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:53:04 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 22:53:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:53:04 INFO - warning: no files found matching '*.txt' 22:53:04 INFO - no previously-included directories found matching 'build' 22:53:04 INFO - no previously-included directories found matching 'dist' 22:53:04 INFO - no previously-included directories found matching '.git*' 22:53:04 INFO - Installing collected packages: jsonschema, functools32 22:53:04 INFO - Running setup.py install for functools32 22:53:04 INFO - warning: no files found matching '*.txt' 22:53:04 INFO - no previously-included directories found matching 'build' 22:53:04 INFO - no previously-included directories found matching 'dist' 22:53:04 INFO - no previously-included directories found matching '.git*' 22:53:04 INFO - Successfully installed jsonschema functools32 22:53:04 INFO - Cleaning up... 22:53:04 INFO - Return code: 0 22:53:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86794f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, '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': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', '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 22:53:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:53:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:53:04 INFO - Using env: {'DISPLAY': ':0', 22:53:04 INFO - 'HOME': '/home/cltbld', 22:53:04 INFO - 'LANG': 'en_US.UTF-8', 22:53:04 INFO - 'LANGUAGE': 'en_US:en', 22:53:04 INFO - 'LOGNAME': 'cltbld', 22:53:04 INFO - 'MAIL': '/var/mail/cltbld', 22:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:04 INFO - 'MOZ_NO_REMOTE': '1', 22:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:04 INFO - 'NO_EM_RESTART': '1', 22:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:04 INFO - 'SHELL': '/bin/bash', 22:53:04 INFO - 'SHLVL': '1', 22:53:04 INFO - 'TERM': 'linux', 22:53:04 INFO - 'TMOUT': '86400', 22:53:04 INFO - 'USER': 'cltbld', 22:53:04 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:04 INFO - '_': '/tools/buildbot/bin/python'} 22:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:04 INFO - Downloading/unpacking flake8 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:53:08 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 22:53:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:53:08 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 22:53:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:08 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 22:53:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:53:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:53:08 INFO - no previously-included directories found matching 'docs/_build' 22:53:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:53:08 INFO - Running setup.py install for pep8 22:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:53:08 INFO - no previously-included directories found matching 'docs/_build' 22:53:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:53:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:53:08 INFO - Cleaning up... 22:53:08 INFO - Return code: 0 22:53:08 INFO - Running post-action listener: _resource_record_post_action 22:53:08 INFO - Running post-action listener: _start_resource_monitoring 22:53:08 INFO - Starting resource monitoring. 22:53:08 INFO - ##### 22:53:08 INFO - ##### Running install step. 22:53:08 INFO - ##### 22:53:08 INFO - Running pre-action listener: _resource_record_pre_action 22:53:08 INFO - Running main action method: install 22:53:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:53:09 INFO - Reading from file tmpfile_stdout 22:53:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:53:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:53:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:53:09 INFO - Reading from file tmpfile_stdout 22:53:09 INFO - Output received: 22:53:09 INFO - Usage: mozinstall [options] installer 22:53:09 INFO - Options: 22:53:09 INFO - -h, --help show this help message and exit 22:53:09 INFO - -d DEST, --destination=DEST 22:53:09 INFO - Directory to install application into. [default: 22:53:09 INFO - "/builds/slave/test-pgo"] 22:53:09 INFO - --app=APP Application being installed. [default: firefox] 22:53:09 INFO - mkdir: /builds/slave/test-pgo/build/application 22:53:09 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'] 22:53:09 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 22:53:25 INFO - Reading from file tmpfile_stdout 22:53:25 INFO - Output received: 22:53:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:53:25 INFO - Running post-action listener: _resource_record_post_action 22:53:25 INFO - ##### 22:53:25 INFO - ##### Running run-tests step. 22:53:25 INFO - ##### 22:53:25 INFO - Running pre-action listener: _resource_record_pre_action 22:53:25 INFO - Running main action method: run_tests 22:53:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:53:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:53:25 INFO - Python 2.7.3 22:53:25 INFO - Return code: 0 22:53:25 INFO - grabbing minidump binary from tooltool 22:53:25 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')]} 22:53:25 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 0x1cf0e40>, '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 0x1cf1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1bf0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:53:25 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 22:53:25 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 22:53:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:53:25 INFO - Return code: 0 22:53:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:53:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:53:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:53:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:53:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:53:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:53:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:53:26 INFO - Return code: 0 22:53:26 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/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 22:53:26 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/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 22:53:26 INFO - Using env: {'DISPLAY': ':0', 22:53:26 INFO - 'HOME': '/home/cltbld', 22:53:26 INFO - 'LANG': 'en_US.UTF-8', 22:53:26 INFO - 'LANGUAGE': 'en_US:en', 22:53:26 INFO - 'LOGNAME': 'cltbld', 22:53:26 INFO - 'MAIL': '/var/mail/cltbld', 22:53:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:53:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:26 INFO - 'MOZ_NO_REMOTE': '1', 22:53:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:26 INFO - 'NO_EM_RESTART': '1', 22:53:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:53:26 INFO - 'SHELL': '/bin/bash', 22:53:26 INFO - 'SHLVL': '1', 22:53:26 INFO - 'TERM': 'linux', 22:53:26 INFO - 'TMOUT': '86400', 22:53:26 INFO - 'USER': 'cltbld', 22:53:26 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934', 22:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:26 INFO - '_': '/tools/buildbot/bin/python'} 22:53:26 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/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 22:53:26 INFO - mozversion application_buildid: 20151231203134 22:53:26 INFO - mozversion application_changeset: 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 22:53:26 INFO - mozversion application_display_name: Nightly 22:53:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:53:26 INFO - mozversion application_name: Firefox 22:53:26 INFO - mozversion application_remotingname: firefox 22:53:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:53:26 INFO - mozversion application_vendor: Mozilla 22:53:26 INFO - mozversion application_version: 46.0a1 22:53:26 INFO - mozversion platform_buildid: 20151231203134 22:53:26 INFO - mozversion platform_changeset: 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 22:53:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:53:26 INFO - mozversion platform_version: 46.0a1 22:53:26 INFO - using testdate: 1451631206 22:53:26 INFO - actual date: 1451631206 22:53:26 INFO - starting webserver on 'localhost:58257' 22:53:26 INFO - SUITE-START | Running 3 tests 22:53:26 INFO - TEST-START | dromaeo_css 22:53:26 INFO - operating with platform_type : linux_ 22:53:26 INFO - Initialising browser for dromaeo_css test... 22:53:26 INFO - TEST-INFO | started process 20461 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNCJheQ/profile http://localhost:58257/getInfo.html) 22:54:28 INFO - PROCESS | 20461 | __metrics Screen width/height:1600/1200 22:54:28 INFO - PROCESS | 20461 | colorDepth:24 22:54:28 INFO - PROCESS | 20461 | Browser inner width/height: 1024/665 22:54:28 INFO - PROCESS | 20461 | __metrics 22:54:28 INFO - PROCESS | 20461 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:54:31 INFO - TEST-INFO | 20461: exit 0 22:54:31 INFO - Browser initialized. 22:54:31 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:31 INFO - TEST-INFO | started process 20596 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNCJheQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:43 INFO - PROCESS | 20596 | RSS: Main: 153710592 22:54:43 INFO - PROCESS | 20596 | 22:55:33 INFO - PROCESS | 20596 | 1451631333068 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] 22:57:42 INFO - PROCESS | 20596 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58257/tests/dromaeo/cssquery-ext.html) 22:57:43 INFO - PROCESS | 20596 | RSS: Main: 158429184 22:57:43 INFO - PROCESS | 20596 | 23:00:45 INFO - PROCESS | 20596 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-ext.html (next: http://localhost:58257/tests/dromaeo/cssquery-jquery.html) 23:00:45 INFO - PROCESS | 20596 | RSS: Main: 155000832 23:00:45 INFO - PROCESS | 20596 | 23:03:47 INFO - PROCESS | 20596 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58257/tests/dromaeo/cssquery-mootools.html) 23:03:48 INFO - PROCESS | 20596 | RSS: Main: 154673152 23:03:48 INFO - PROCESS | 20596 | 23:06:49 INFO - PROCESS | 20596 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58257/tests/dromaeo/cssquery-prototype.html) 23:06:50 INFO - PROCESS | 20596 | RSS: Main: 152977408 23:06:50 INFO - PROCESS | 20596 | 23:09:52 INFO - PROCESS | 20596 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58257/tests/dromaeo/cssquery-yui.html) 23:09:53 INFO - PROCESS | 20596 | RSS: Main: 154509312 23:09:53 INFO - PROCESS | 20596 | 23:12:55 INFO - PROCESS | 20596 | Cycle 1(1): loaded http://localhost:58257/tests/dromaeo/cssquery-yui.html (next: http://localhost:58257/tests/dromaeo/cssquery-dojo.html) 23:12:56 INFO - PROCESS | 20596 | RSS: Main: 156049408 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | __start_tp_report 23:12:56 INFO - PROCESS | 20596 | _x_x_mozilla_page_load 23:12:56 INFO - PROCESS | 20596 | _x_x_mozilla_page_load_details 23:12:56 INFO - PROCESS | 20596 | |i|pagename|runs| 23:12:56 INFO - PROCESS | 20596 | |0;dojo.html;3169.6037995250595;3236.3203727217283;3247.9188020299503;3267.0852161394805;3275.55779969704;5287.4976877196705;5348.117560602505;5351.876106017736;5361.035013697538;5394.3796463406625;5310;5311.973440132803;5390.4879036491475;5447.564194864412;5470.91793623095;4874.731889746063;4916.090523253191;4972.87567810804;5001.524855138774;5010.924836127461;4972.453030166696;4985.6260780441435;5041.495850414965;5045.596352291826;5077.898442031157;4852.733099679516;4891.315215869781;4939.086269040203;4974.676646018033;5030.723310217936;4891.339669144655;4913.828016019458;4930.654854160211;4934.629902757308;4948.777305021283;4881.8535443936735;4911.263310503417;4917.311576379309;4917.8278760243575;4924.729139897304;5094;5191.377034755816;5201.895962080737;5280.841574752763;5342.519173274424;5779.479846813807;5791.131330300489;5795.82612521625;5801.24583804107;5812.912806307909;5788.247527821356;5839.970800146015;5841.065429531254;5844.064949608085;5850.473457388813;5344.171653393731;5395.514403703646;5412.810551630674;5440.238366628675;5453.618246722692;5968.22413086296;5983.37174596661;5986.850328741816;6009.729562169713;6028.306744724413;5760.683162426107;5762.538996880239;5762.94237057624;5767.307923049261;5774.105013722879;5612.747426365823;5680.97159514208;5827.679477628772;5845.357010728816;5958;5726.169705392695;5751.396103409082;5753.367129615739;5759.049756790167;5766.04860198071;5727.39862314451;5735.799247026334;5748.798792042258;5754.482096611241;5764.913526297109;4344.522102568715;4413.58070983256;4445.044315472189;4463.910721785546;4477.194105061055;3932.941005884914;3944.5463771666628;3961.3067713150085;4005.319095753729;4022.6580740637373;5285.973570132125;5398.541124004503;5418.864528386822;5425.782968681208;5438.265834112423;5737.139429085671;5819.185314056035;5826.155207494974;5852.473277405054;5887.175795388649;5433.646812957145;5434.456554344534;5437.972810136003;5438.592105592017;5441.673499589958;4891.779869905863;4939.90120197594;4956.702597844141;4963.329950456714;5006.048850718352;5870.970645146747;5937.109433584997;5951.5238780897425;5956.076808094752;5977.312609049928;5673.234113394639;5750.396208398225;5750.827475175752;5753;5771.134329850556;5894.911576326444;5920.940790592212;5922.73347699346;5938.703064846654;6036.9698151508965;5707.857303567444;5795.39148389413;5796.565257605612;5798.913016304843;5854.619449735754;5848.912266315923;5870;5902.1441890926435;5903.881922361615;5917.644941303535;5600.915986260128;5697.173909783141;5735.11105778605;5749.195112684144;5758.1650660654805;5592.580556458201;5627.662340259598;5670.5180059695385;5727.083666613322;5751.827445176651;5605.243292155506;5607.523360514402;5627.746751396279;5643.3792282848035;5646.689432081275;5562.638428502134;5680.517156041783;5689.260396148474;5726.2269593606;5736.6558006519745;5460.972695136499;5518.86202844916;5520.641158324696;5525.309336332958;5567.053600887778 23:12:56 INFO - PROCESS | 20596 | |1;ext.html;545.5117669685629;556.4796914884582;563.7322271920838;567.8580354911272;573.1631817546382;34695.65304346956;35569.2886142277;35918.28163436736;35943;36046.819765901164;39455;39908.201835963264;40112.79943600285;40207.798961005225;40296.395554066716;8494.362922780785;8504.744857654281;8628.223459888608;8634;8636.827263454727;8232.382571307146;8336.749897503085;8361.83276334473;8634.870476942819;8640.697575584856;8655.913440865605;8696.912885889264;8718.38971272008;8725.520096394695;8756.168164024408;8697.434666746673;8804.03155652881;8814.33892458065;8814.427062240933;8816.294696424271;8546.2308392245;8738.781530461725;8760.78098047554;8770.298376129895;8785;39844.20311593781;40274;40409;40451;40468.595314046775;3341.2649217172425;3361.6302206757236;3439.7592168548213;3460.9271125950786;3566.696830769388;29454.852725736448;29624.40751184986;29672.70327296721;29862;30050.398992020037;3415.9146021349416;3485.7559970802054;3565.536480257576;3584.802835844054;3724.7206459515646;273351;274903;275425;275748;276088;41461;41894.58105418968;42209.788951055045;54787;55185.44814551803;40221;40385;40405.1918961625;40482.79758601188;40524;14093.2248726319;14130.15219086858;14211.50259740904;14283.928580357031;14315.78526322106;11371.943140284246;11375.943120284346;11402.315861048364;11524.423778811026;11531.654050378502;14196.64508387278;14347.56957291283;14396.496122635657;14438.783418248735;14465.78301325481;5703;5814.622049566765;5820.534357251409;5959.28488581373;5997.160397544348;942.8962814090445;983.8524221366853;997.6258902911409;1026.1175389165312;1096.17786660005;27932.720672793417;28202.576961345596;28616.570751438747;28819.855900720362;28881.85559072233;1081.4754843900703;1084.749145523043;1126.8873112688666;1161.517970042423;1189.1141099880472;14846.257687115602;14848.554543363716;14976.47582334613;15078.924605377122;15083.773743393858;299872;300749;300922;302191;303535;51704;51762.22356664653;51769.22346164811;51775.74112129415;51956.74021629943;1356.9728605428033;1361.2309045389322;1383.4397069187196;1394.9163050217019;1405.3605609447677;26393;27679;27748.819310827195;28118.156455306373;28418.57372139461;45926.54073459223;46170.76914615405;46201.306980395995;46348.07303853972;46526.76736616295;283223;285555;286034;286058;286717;32534.511982320757;42764;42788.57211427846;43738.56261437345;43819;38871.60464281454;38982;39476.605233947295;39508.802455987534;39720.205595888496;34577.48133778045;35856.28287434289;36111.0972225686;36995.44506832346;37085.25829483341;36416.45375319319;36504;37006.44490332701;37292.627073728916;37394;35389.46915796317;35928;36225.27549449049;36237.275254494234;36254.637453625124;30134.547981780728;33140;33658.475614328534;33669.49495757517;33710;25296.873515632305;25580.10469633554;25594.488110238064;25710.611060707033;25920 23:12:56 INFO - PROCESS | 20596 | |2;jquery.html;336.99494507582403;342.20778896853795;345.45590694655925;346.0586111912173;350.1142110460534;11512.712182195428;11783.351915644636;16370.18149092545;16876.83123168768;18296;16355.59111022225;16478.176091195422;18031.647626428006;18422;18427.249411305904;5691.117876729114;5864.149698293766;5909.704514774266;5927.081302398114;5928.911066334009;5814.331351894522;5832.300123985127;5870.88258234835;5887.793927212549;6216;6296.968515157418;6400.871982560346;6405.455536279399;6412.967935160318;6488.124103246072;6424.13274207983;6443.29123796382;6444.806655800334;6450.838729031765;6873.140857392826;6552.148220731322;6571.57284776488;6596.835079123012;6620;6626.56927299724;20891.477713057142;22018;22660.20689275884;22996.54006919869;23031.884840575858;1929.0547631660525;2076.1280262289874;2195.8243340532877;2209.9668504972437;2243.921462748796;13836.446542138303;14039.438422463089;14128.717425651532;14322.355494002795;14443.494477693335;1923.1249781349452;1966.3216190414284;1989.3634037108131;1995.820376166152;2004.6291436084225;63823;65090;70202.64898675474;72996.63501682457;74195.62902185509;15546.989445685995;15599.064056156667;15653.686926261411;15724.528264152093;15727.528174154793;23763;24058.759412405652;24340.7565924342;24493.877530612233;24523.632145517833;8758.737237882873;8813.25087367568;8819.559022048872;8846.46921184731;8876.245519130816;7385.4460915431555;7398.297161769623;7440.85118297631;7443.739469118555;7468.589227592426;7682.270184332479;7785.688572457038;7845.333146682482;7871.921280787234;8025.23760242776;1753.587906841891;3022.637283525947;3055.541668749661;3090.9027295309843;3188.6333071696586;764.5298141642961;894.0433735902521;917.1699611851285;990.8365119755304;1034.6999370182714;16093.034417934961;16704.41534546285;16707.331706731595;17110.315587376364;17250.568735781453;925.9537023148815;959.5969692728931;969;970.4177493503983;1016.4460369098858;9248.537573121317;9354.029147769561;9362.719118426457;9673.419594824332;9676.322657414054;539399;543470;546542;546803;547240;31971;32054.519182212287;43663;75367;78240.60879695565;1161.6224726963771;1163.1741463560966;1167.0663469224587;1168.3982748884332;1178.0869825885009;14774.926125369304;15100.773488397903;15173;15181.392744290546;15406.614834629225;33407.49888751622;33420.66579334175;33884.32231355408;34254.14364640904;34332.97001089971;44888.55111448844;45124.09751805011;45232.32151517796;45269.77365113285;49603.75198123986;9596.18432433251;9706.805863882542;9756.170725488413;9821.214302855897;9825.312228143961;16509.17454127265;16529.19003769338;17209.483715488554;17341.219645116253;17350.219240134476;13744.725105498033;13908.165510069428;13925.164490130624;14308.785368219276;14664.926675366982;13446.663833403853;13552;13622;14155.575332740034;14328.426862925366;13453.596392108253;13778.517751878637;14114.858851411765;14606.196659183846;15321.387144514094;9058.773530661787;9525.618975240914;9771.511424428892;9778.16885564735;9832.55753491109;13539.390727417092;13649.727005460034;14729.26353682333;15001;15032 23:12:56 INFO - PROCESS | 20596 | |3;mootools.html;1452.1650051220547;1464.0849469081825;1620.6191544986925;1756.1833747307498;1767.3019157432807;6638.8008359749165;6760.256371799098;7334.633268336582;7475.364594009509;7501.174870764212;7083.1854336751285;7150.249223831488;7236.638168091601;7242.674079666414;7258.673359698813;2251.752307246206;2302.159711705224;2317.4669825940045;2321.315212012452;2322.7909488146065;2225.432514708755;2257.6500642400374;2259.243153543565;2267;2267.263139479676;2228.2980861028805;2251.7410497792716;2271.4548508357957;2287.0165828693657;2303.7465878753324;2225.643896976476;2239.1826983151195;2261.7625149359246;2262.9207977720785;2264.637657974716;2297.4715815362392;2310.8151347892294;2320.3271051395077;2323.3494621506006;2324.140068174786;7380.963095184544;7432.739854105081;7445.85108297831;7462.216467270912;7475.401967842559;4591.242444996572;4614.984703365254;4634.86095417138;4655.674102812804;4663.766811659403;3052.938941221163;3079.230192451887;3136.6549679535233;3146.3078122812944;3187.15540381799;996.9900300996969;1003.6336737090983;1854.2119599170298;1857.8606604504716;1868.5795695968434;9731.951340243324;9850.655227067018;9860.359076660066;9878.259130565237;9901.504924753734;3926.1362500249897;3988.142549351903;4020.3366444536323;4055.9797201013807;4062.289099407592;8367.581620918929;8430.789230269293;8460.534670593177;8466.32269418445;8480.406371554056;4519.932201016987;4531.977340113344;4543.5910768031035;4547.272436410159;4559.726416415026;4118.19695159441;4213.304804707189;4227.027783609787;4251.362295655615;4262.616364527207;3553.3603951289015;3562.98218508911;3563.3051554947056;3570.839312230956;3606.6213047630145;1091.170710260208;1093.1691914145306;1095.2606990281529;1107.6510899066768;1109.2013750099916;1013.1793247469426;1048.8374301983206;1152.9423528823525;1159.263867444162;1166.9474873630706;6579.144711187515;6720.731170753213;6736.93263067363;6759.662016899136;6759.898601520981;1112.4271000434783;1139.1968662093204;1144.9713757156137;1150.8158694608821;1163.755611321615;5592.692401917852;5609.214709940612;5626.915596266059;5634.971825140848;5642.774289028475;8351.331893448509;8810.383273170944;8818.823623527494;8897.599608017656;8935.463872167691;8699.478031318142;8772.385932984758;8821.073787252375;8880.8667869982;8894.42186257891;6667.86664266712;6757.729690812411;6775.288594697585;6812.62530560814;6978.651067446607;6747.493937954771;6754.3921047106;6756;6761.0534525167495;6776.898346524707;7757.92242077572;8107.756767296991;8146.75559733209;8156.9184308156155;8180.590970451334;8114.756557303291;8130.268275855202;8159.061707903667;8162.428629995843;8292.834143316979;6321.11504389395;6380;6528.543001990005;6721.764738234138;6732;7184.1019872515935;7217.963910180415;7237.674304656198;7238.8914166286495;7256.310650488195;6707.698153583198;6796.150481189851;6858.279880612663;6888.104546408935;6987.895181572382;6688.632125233159;6761.763338283333;6762.8647427052165;6791.524593278423;6817.522773405814;6379.87240255183;6725.428338591275;6750.932490675031;6757.831054223487;6782.796516104525;5661.688607126647;5693.914591281051;5694.402087780723;5703.429657034263;5713.342965559014;6056.36408177135;6140.263168419819;6144.801763656044;6158.630482171084;6164.876702466016 23:12:56 INFO - PROCESS | 20596 | |4;prototype.html;323.68925831202046;326.5265365220428;328.64670479234815;329.97855139415935;334.63859032245176;6259.687015649217;6289.591176573525;6318.178636777213;6380.3300653431415;6494.0583615375745;6247.468965137958;6260.2487701475775;6318.5892916960365;6342.175517182772;6360.109584658151;4774.427068751755;4778.713277203362;4781.115493633689;4782.33047373368;4783.186858234099;4733.5976442002475;4786.56920877121;4789.425268967729;4789.544993225638;4791.496892826255;4635.281531362644;4698.90602187956;4712.599429048535;4723.48041715411;4724.149653062447;4703.976480117594;4709.293605959099;4725.881852953669;4730.432348118248;4730.597899178557;4074.979625101885;4075.9810047488127;4080.9387859182134;4082.7754473503946;4086.244044851712;5937.228160339171;5961.433663801975;5992.250968628921;5992.880142397127;6034.728437220336;5404.135338345845;5482.698451585161;5483.314585676791;5489.58828087891;5501.559875209973;6676.833079173011;6696.86606267872;6700.698468568926;6705.6982435790505;6718.093057437232;4477.798499067517;4478.708883922567;4488.708233964782;4488.8877778055485;4498.122866041123;6835.14560679915;6920.619365934872;6941.548799328078;6978.720851165947;6981.79054628362;4544.159330523864;4551.590356867898;4554.749488778083;4556.658250631216;4565.338025986213;4620.53794620542;4624.9768751156025;4629.976850115728;4631.536846315342;4638.072385522909;5433.972830135824;5437.809676661298;5439.184122381595;5440.727963601804;5443.863903402446;6480.351964803576;6641.966790166115;6646.8005959821285;6654.6007239564815;6724.327567243236;1600.8393914411959;1629.372691513752;1643.3262362431585;1643.416587111582;1644.9177541123136;1049.905508504223;1064.7817197474499;1066.5040756048475;1076.8223243164946;1086.3373342261214;6275.623462592259;6337.176167098248;6339.334369891095;6339.492840572835;6345.143405640272;6799.606080753434;6840.0765896603325;6844.931550684529;6850.3149685032095;6855.314468553204;6186.412290832363;6325.620462772248;6331.398517140864;6334.461570766536;6340.968295158495;3690.5940346561856;3722.441633754904;3725.0501122214205;3725.9441108383394;3733.533308336458;7064.43484521237;7070.292970702889;7114.964425177841;7118.501704880712;7154.713811447484;6900.102986611809;6999.895001574981;7006.369426751617;7010.263922288086;7027.332403421667;7174.390176834923;7184.856302874018;7188.353048225685;7199.1001124859395;7221.747238846615;6853.657317134223;6956.40870526011;6982.860342793014;6987.196472405739;7011.193712723102;6724.966375168093;6854.074699915447;6897.206821215625;6899.379055884994;6903.722811279929;7190.784276471714;7211.819704507429;7224.2414546473965;7226.602536860523;7293.52592081513;4702.576768090751;4712.740799256074;4741.739204343794;4765.4996225395835;4767.928481072718;6848.9657551711925;6877.415419689382;6881.41507971828;6952.652367381509;6999.370056694922;6809.5233333666165;6829.93170068293;6835.760748373783;6852.040714299902;6864.828379290558;6796.72813087471;6824.761133360308;6830.282820303796;6832.897506537306;6834.589924604539;6544.149260596092;6670.433013193933;6689.866202676017;6697.196336439659;6702.430293425114;6808.761693340709;6809.080774095433;6813;6821.386075253251;6834.350736680008;6629.7348106075215;6629.966850165718;6631.834204144935;6633.170853643294;6660.56706314088 23:12:56 INFO - PROCESS | 20596 | |5;yui.html;782.4679218131671;853.1638993786089;853.8701839639015;868.9869651955222;874.2656168818191;12814.551490697828;12967.221966682006;13055.93472032641;13081.54214602489;13115.409806558715;12617.747645047093;12703.428345724442;12704.428300726466;12720.173188742725;12725.809112863315;668.7325069972002;687.2440315652767;814.8370325934836;837.4891316297054;844.5608283692476;818.3207937411934;824.056455358614;832.2426591801462;832.7501749475164;833.1793183714037;881.497546398553;887.7114937645259;888.1873086126187;890.8307421589877;892.3218354050903;862.7023676831483;877.3025444771422;879.4898958603994;880.1418616848554;881.9470831750116;632.3076231526517;634.2769243062912;635.3519410201615;646.1180488633029;651.3649192037773;12893.097483176181;12913.935430322883;12943.870561294361;12955.352232388343;13121.147125436815;11892.345920974343;12099.274043557327;12425;12709.364531773466;12750.80873786894;9934.354266972623;10291.845622315672;10528.631497897613;10532.526036328383;10704.839427408595;3598.1544337080763;3608.025833025095;3656.5063716398213;3720.7023438124884;3737.682297004758;49313.50686493125;49542.7522862387;50097;50151.74924125393;50323.74838125786;9261.814763704822;9516.23870090391;9584.808303833885;9884.064740872584;9961.103500684972;17730.113494325233;17871.463856084338;17908;17947.551311217325;18010.36963706264;6600.768973085919;6925.168979722465;7204.0994875640545;7311.744088956861;7388.408927285805;4028.1339512004474;4064.3700226464944;4083.4283200351974;4096.467459230281;4223.493180818322;2995.341024974502;3041.81749095055;3042.39152169567;3045.482268014443;3086.135881953057;535.8446050645347;540.1573545269314;540.1762312473431;547.1683041776478;559.6278474814285;554.4483239176964;563.1018525451898;628.8302158417201;647.145767586781;651.9047999361119;7545.396368290523;7552.244775522404;7564.773056808304;7852.175521570267;7896.881546776803;556.8607848037991;619.3247266145066;644.7825351496094;694.8957656351588;709.4187390844382;3699.648533389324;3724.42271447926;3787.981060094682;3829.636184562518;3843.3466310727244;52634.73682631639;52803.73598131985;52805.2079218812;53391.73304133532;53462.73268633632;48691.26963095556;49323.75338123286;50631.49368506341;51180.48819511757;51542.48457515452;45678;45716.3142552862;45944.54055459469;46232.5376746235;46668;7441.739539116105;7534.35957943581;7537.924620753942;7676.347510461674;7762.41781866351;33398.833005834815;33413.49879751757;33612;33903;34005.319893602486;39852;43065.78467107644;44031.11937761163;44057.77971110124;44679.10641787211;9538.523073846141;9692.176165026052;9858.704238872846;9963.402195868272;10032.670773374392;10949.56201751921;10961.451927403758;11170.27393219438;11183.273087249303;11637.185397022127;9326.207272381924;9391.154796068387;9508.381955172892;9635.22918166559;9838.508074596099;10617.840732388866;10793.56825726962;10844;11064.170187235828;11413.201075924937;10220.897791021995;10427.612484557796;10460.63387781424;10531.94734026325;10651.786964260516;9553.331266811256;9605.18355939753;9721.805563888824;9733.659321923698;9862.112409883144;7692.614650984264;8378.790530236793;8599.355048371272;8605.98612131111;8772.122787721177 23:12:56 INFO - PROCESS | 20596 | __end_tp_report 23:12:56 INFO - PROCESS | 20596 | __start_cc_report 23:12:56 INFO - PROCESS | 20596 | _x_x_mozilla_cycle_collect,324 23:12:56 INFO - PROCESS | 20596 | __end_cc_report 23:12:56 INFO - PROCESS | 20596 | __startTimestamp1451632376020__endTimestamp 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | ------- Summary: start ------- 23:12:56 INFO - PROCESS | 20596 | Number of tests: 6 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | [#0] dojo.html Cycles:165 Average:5380.14 Median:5600.92 stddev:599.02 (10.7%) stddev-sans-first:575.21 23:12:56 INFO - PROCESS | 20596 | Values: 3169.6 3236.3 3247.9 3267.1 3275.6 5287.5 5348.1 5351.9 5361.0 5394.4 5310.0 5312.0 5390.5 5447.6 5470.9 4874.7 4916.1 4972.9 5001.5 5010.9 4972.5 4985.6 5041.5 5045.6 5077.9 4852.7 4891.3 4939.1 4974.7 5030.7 4891.3 4913.8 4930.7 4934.6 4948.8 4881.9 4911.3 4917.3 4917.8 4924.7 5094.0 5191.4 5201.9 5280.8 5342.5 5779.5 5791.1 5795.8 5801.2 5812.9 5788.2 5840.0 5841.1 5844.1 5850.5 5344.2 5395.5 5412.8 5440.2 5453.6 5968.2 5983.4 5986.9 6009.7 6028.3 5760.7 5762.5 5762.9 5767.3 5774.1 5612.7 5681.0 5827.7 5845.4 5958.0 5726.2 5751.4 5753.4 5759.0 5766.0 5727.4 5735.8 5748.8 5754.5 5764.9 4344.5 4413.6 4445.0 4463.9 4477.2 3932.9 3944.5 3961.3 4005.3 4022.7 5286.0 5398.5 5418.9 5425.8 5438.3 5737.1 5819.2 5826.2 5852.5 5887.2 5433.6 5434.5 5438.0 5438.6 5441.7 4891.8 4939.9 4956.7 4963.3 5006.0 5871.0 5937.1 5951.5 5956.1 5977.3 5673.2 5750.4 5750.8 5753.0 5771.1 5894.9 5920.9 5922.7 5938.7 6037.0 5707.9 5795.4 5796.6 5798.9 5854.6 5848.9 5870.0 5902.1 5903.9 5917.6 5600.9 5697.2 5735.1 5749.2 5758.2 5592.6 5627.7 5670.5 5727.1 5751.8 5605.2 5607.5 5627.7 5643.4 5646.7 5562.6 5680.5 5689.3 5726.2 5736.7 5461.0 5518.9 5520.6 5525.3 5567.1 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | [#1] ext.html Cycles:180 Average:44793.34 Median:36078.96 stddev:75056.30 (208.0%) stddev-sans-first:75193.33 23:12:56 INFO - PROCESS | 20596 | Values: 545.5 556.5 563.7 567.9 573.2 34695.7 35569.3 35918.3 35943.0 36046.8 39455.0 39908.2 40112.8 40207.8 40296.4 8494.4 8504.7 8628.2 8634.0 8636.8 8232.4 8336.7 8361.8 8634.9 8640.7 8655.9 8696.9 8718.4 8725.5 8756.2 8697.4 8804.0 8814.3 8814.4 8816.3 8546.2 8738.8 8760.8 8770.3 8785.0 39844.2 40274.0 40409.0 40451.0 40468.6 3341.3 3361.6 3439.8 3460.9 3566.7 29454.9 29624.4 29672.7 29862.0 30050.4 3415.9 3485.8 3565.5 3584.8 3724.7 273351.0 274903.0 275425.0 275748.0 276088.0 41461.0 41894.6 42209.8 54787.0 55185.4 40221.0 40385.0 40405.2 40482.8 40524.0 14093.2 14130.2 14211.5 14283.9 14315.8 11371.9 11375.9 11402.3 11524.4 11531.7 14196.6 14347.6 14396.5 14438.8 14465.8 5703.0 5814.6 5820.5 5959.3 5997.2 942.9 983.9 997.6 1026.1 1096.2 27932.7 28202.6 28616.6 28819.9 28881.9 1081.5 1084.7 1126.9 1161.5 1189.1 14846.3 14848.6 14976.5 15078.9 15083.8 299872.0 300749.0 300922.0 302191.0 303535.0 51704.0 51762.2 51769.2 51775.7 51956.7 1357.0 1361.2 1383.4 1394.9 1405.4 26393.0 27679.0 27748.8 28118.2 28418.6 45926.5 46170.8 46201.3 46348.1 46526.8 283223.0 285555.0 286034.0 286058.0 286717.0 32534.5 42764.0 42788.6 43738.6 43819.0 38871.6 38982.0 39476.6 39508.8 39720.2 34577.5 35856.3 36111.1 36995.4 37085.3 36416.5 36504.0 37006.4 37292.6 37394.0 35389.5 35928.0 36225.3 36237.3 36254.6 30134.5 33140.0 33658.5 33669.5 33710.0 25296.9 25580.1 25594.5 25710.6 25920.0 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | [#2] jquery.html Cycles:180 Average:29304.45 Median:16878.83 stddev:88654.78 (525.2%) stddev-sans-first:88876.79 23:12:56 INFO - PROCESS | 20596 | Values: 337.0 342.2 345.5 346.1 350.1 11512.7 11783.4 16370.2 16876.8 18296.0 16355.6 16478.2 18031.6 18422.0 18427.2 5691.1 5864.1 5909.7 5927.1 5928.9 5814.3 5832.3 5870.9 5887.8 6216.0 6297.0 6400.9 6405.5 6413.0 6488.1 6424.1 6443.3 6444.8 6450.8 6873.1 6552.1 6571.6 6596.8 6620.0 6626.6 20891.5 22018.0 22660.2 22996.5 23031.9 1929.1 2076.1 2195.8 2210.0 2243.9 13836.4 14039.4 14128.7 14322.4 14443.5 1923.1 1966.3 1989.4 1995.8 2004.6 63823.0 65090.0 70202.6 72996.6 74195.6 15547.0 15599.1 15653.7 15724.5 15727.5 23763.0 24058.8 24340.8 24493.9 24523.6 8758.7 8813.3 8819.6 8846.5 8876.2 7385.4 7398.3 7440.9 7443.7 7468.6 7682.3 7785.7 7845.3 7871.9 8025.2 1753.6 3022.6 3055.5 3090.9 3188.6 764.5 894.0 917.2 990.8 1034.7 16093.0 16704.4 16707.3 17110.3 17250.6 926.0 959.6 969.0 970.4 1016.4 9248.5 9354.0 9362.7 9673.4 9676.3 539399.0 543470.0 546542.0 546803.0 547240.0 31971.0 32054.5 43663.0 75367.0 78240.6 1161.6 1163.2 1167.1 1168.4 1178.1 14774.9 15100.8 15173.0 15181.4 15406.6 33407.5 33420.7 33884.3 34254.1 34333.0 44888.6 45124.1 45232.3 45269.8 49603.8 9596.2 9706.8 9756.2 9821.2 9825.3 16509.2 16529.2 17209.5 17341.2 17350.2 13744.7 13908.2 13925.2 14308.8 14664.9 13446.7 13552.0 13622.0 14155.6 14328.4 13453.6 13778.5 14114.9 14606.2 15321.4 9058.8 9525.6 9771.5 9778.2 9832.6 13539.4 13649.7 14729.3 15001.0 15032.0 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | [#3] mootools.html Cycles:180 Average:5211.44 Median:6142.53 stddev:2585.10 (42.1%) stddev-sans-first:2576.91 23:12:56 INFO - PROCESS | 20596 | Values: 1452.2 1464.1 1620.6 1756.2 1767.3 6638.8 6760.3 7334.6 7475.4 7501.2 7083.2 7150.2 7236.6 7242.7 7258.7 2251.8 2302.2 2317.5 2321.3 2322.8 2225.4 2257.7 2259.2 2267.0 2267.3 2228.3 2251.7 2271.5 2287.0 2303.7 2225.6 2239.2 2261.8 2262.9 2264.6 2297.5 2310.8 2320.3 2323.3 2324.1 7381.0 7432.7 7445.9 7462.2 7475.4 4591.2 4615.0 4634.9 4655.7 4663.8 3052.9 3079.2 3136.7 3146.3 3187.2 997.0 1003.6 1854.2 1857.9 1868.6 9732.0 9850.7 9860.4 9878.3 9901.5 3926.1 3988.1 4020.3 4056.0 4062.3 8367.6 8430.8 8460.5 8466.3 8480.4 4519.9 4532.0 4543.6 4547.3 4559.7 4118.2 4213.3 4227.0 4251.4 4262.6 3553.4 3563.0 3563.3 3570.8 3606.6 1091.2 1093.2 1095.3 1107.7 1109.2 1013.2 1048.8 1152.9 1159.3 1166.9 6579.1 6720.7 6736.9 6759.7 6759.9 1112.4 1139.2 1145.0 1150.8 1163.8 5592.7 5609.2 5626.9 5635.0 5642.8 8351.3 8810.4 8818.8 8897.6 8935.5 8699.5 8772.4 8821.1 8880.9 8894.4 6667.9 6757.7 6775.3 6812.6 6978.7 6747.5 6754.4 6756.0 6761.1 6776.9 7757.9 8107.8 8146.8 8156.9 8180.6 8114.8 8130.3 8159.1 8162.4 8292.8 6321.1 6380.0 6528.5 6721.8 6732.0 7184.1 7218.0 7237.7 7238.9 7256.3 6707.7 6796.2 6858.3 6888.1 6987.9 6688.6 6761.8 6762.9 6791.5 6817.5 6379.9 6725.4 6750.9 6757.8 6782.8 5661.7 5693.9 5694.4 5703.4 5713.3 6056.4 6140.3 6144.8 6158.6 6164.9 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | [#4] prototype.html Cycles:180 Average:5569.83 Median:6335.82 stddev:1720.45 (27.2%) stddev-sans-first:1679.61 23:12:56 INFO - PROCESS | 20596 | Values: 323.7 326.5 328.6 330.0 334.6 6259.7 6289.6 6318.2 6380.3 6494.1 6247.5 6260.2 6318.6 6342.2 6360.1 4774.4 4778.7 4781.1 4782.3 4783.2 4733.6 4786.6 4789.4 4789.5 4791.5 4635.3 4698.9 4712.6 4723.5 4724.1 4704.0 4709.3 4725.9 4730.4 4730.6 4075.0 4076.0 4080.9 4082.8 4086.2 5937.2 5961.4 5992.3 5992.9 6034.7 5404.1 5482.7 5483.3 5489.6 5501.6 6676.8 6696.9 6700.7 6705.7 6718.1 4477.8 4478.7 4488.7 4488.9 4498.1 6835.1 6920.6 6941.5 6978.7 6981.8 4544.2 4551.6 4554.7 4556.7 4565.3 4620.5 4625.0 4630.0 4631.5 4638.1 5434.0 5437.8 5439.2 5440.7 5443.9 6480.4 6642.0 6646.8 6654.6 6724.3 1600.8 1629.4 1643.3 1643.4 1644.9 1049.9 1064.8 1066.5 1076.8 1086.3 6275.6 6337.2 6339.3 6339.5 6345.1 6799.6 6840.1 6844.9 6850.3 6855.3 6186.4 6325.6 6331.4 6334.5 6341.0 3690.6 3722.4 3725.1 3725.9 3733.5 7064.4 7070.3 7115.0 7118.5 7154.7 6900.1 6999.9 7006.4 7010.3 7027.3 7174.4 7184.9 7188.4 7199.1 7221.7 6853.7 6956.4 6982.9 6987.2 7011.2 6725.0 6854.1 6897.2 6899.4 6903.7 7190.8 7211.8 7224.2 7226.6 7293.5 4702.6 4712.7 4741.7 4765.5 4767.9 6849.0 6877.4 6881.4 6952.7 6999.4 6809.5 6829.9 6835.8 6852.0 6864.8 6796.7 6824.8 6830.3 6832.9 6834.6 6544.1 6670.4 6689.9 6697.2 6702.4 6808.8 6809.1 6813.0 6821.4 6834.4 6629.7 6630.0 6631.8 6633.2 6660.6 23:12:56 INFO - PROCESS | 20596 | 23:12:56 INFO - PROCESS | 20596 | [#5] yui.html Cycles:180 Average:13295.66 Median:52719.24 stddev:15578.36 (29.5%) stddev-sans-first:15593.72 23:12:56 INFO - PROCESS | 20596 | Values: 782.5 853.2 853.9 869.0 874.3 12814.6 12967.2 13055.9 13081.5 13115.4 12617.7 12703.4 12704.4 12720.2 12725.8 668.7 687.2 814.8 837.5 844.6 818.3 824.1 832.2 832.8 833.2 881.5 887.7 888.2 890.8 892.3 862.7 877.3 879.5 880.1 881.9 632.3 634.3 635.4 646.1 651.4 12893.1 12913.9 12943.9 12955.4 13121.1 11892.3 12099.3 12425.0 12709.4 12750.8 9934.4 10291.8 10528.6 10532.5 10704.8 3598.2 3608.0 3656.5 3720.7 3737.7 49313.5 49542.8 50097.0 50151.7 50323.7 9261.8 9516.2 9584.8 9884.1 9961.1 17730.1 17871.5 17908.0 17947.6 18010.4 6600.8 6925.2 7204.1 7311.7 7388.4 4028.1 4064.4 4083.4 4096.5 4223.5 2995.3 3041.8 3042.4 3045.5 3086.1 535.8 540.2 540.2 547.2 559.6 554.4 563.1 628.8 647.1 651.9 7545.4 7552.2 7564.8 7852.2 7896.9 556.9 619.3 644.8 694.9 709.4 3699.6 3724.4 3788.0 3829.6 3843.3 52634.7 52803.7 52805.2 53391.7 53462.7 48691.3 49323.8 50631.5 51180.5 51542.5 45678.0 45716.3 45944.5 46232.5 46668.0 7441.7 7534.4 7537.9 7676.3 7762.4 33398.8 33413.5 33612.0 33903.0 34005.3 39852.0 43065.8 44031.1 44057.8 44679.1 9538.5 9692.2 9858.7 9963.4 10032.7 10949.6 10961.5 11170.3 11183.3 11637.2 9326.2 9391.2 9508.4 9635.2 9838.5 10617.8 10793.6 10844.0 11064.2 11413.2 10220.9 10427.6 10460.6 10531.9 10651.8 9553.3 9605.2 9721.8 9733.7 9862.1 7692.6 8378.8 8599.4 8606.0 8772.1 23:12:56 INFO - PROCESS | 20596 | -------- Summary: end -------- 23:12:56 INFO - PROCESS | 20596 | 23:12:57 INFO - TEST-INFO | 20596: exit 0 23:12:57 INFO - TEST-OK | dromaeo_css | took 1171126ms 23:12:57 INFO - TEST-START | kraken 23:12:57 INFO - operating with platform_type : linux_ 23:12:57 INFO - Initialising browser for kraken test... 23:12:57 INFO - TEST-INFO | started process 20828 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDnjpw9/profile http://localhost:58257/getInfo.html) 23:13:11 INFO - PROCESS | 20828 | __metrics Screen width/height:1600/1200 23:13:11 INFO - PROCESS | 20828 | colorDepth:24 23:13:11 INFO - PROCESS | 20828 | Browser inner width/height: 1024/697 23:13:11 INFO - PROCESS | 20828 | __metrics 23:13:11 INFO - PROCESS | 20828 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:12 INFO - PROCESS | 20828 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 23:13:15 INFO - TEST-INFO | 20828: exit 0 23:13:15 INFO - Browser initialized. 23:13:15 INFO - Running cycle 1/1 for kraken test... 23:13:15 INFO - TEST-INFO | started process 20946 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDnjpw9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:27 INFO - PROCESS | 20946 | RSS: Main: 150818816 23:13:27 INFO - PROCESS | 20946 | 23:13:29 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:30 INFO - PROCESS | 20946 | RSS: Main: 152342528 23:13:30 INFO - PROCESS | 20946 | 23:13:32 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-dft) 23:13:33 INFO - PROCESS | 20946 | RSS: Main: 151601152 23:13:33 INFO - PROCESS | 20946 | 23:13:36 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-fft) 23:13:36 INFO - PROCESS | 20946 | RSS: Main: 146616320 23:13:36 INFO - PROCESS | 20946 | 23:13:38 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58257/tests/kraken/driver.html?testName=audio-oscillator) 23:13:39 INFO - PROCESS | 20946 | RSS: Main: 146669568 23:13:39 INFO - PROCESS | 20946 | 23:13:41 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:42 INFO - PROCESS | 20946 | RSS: Main: 147230720 23:13:42 INFO - PROCESS | 20946 | 23:13:45 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:45 INFO - PROCESS | 20946 | RSS: Main: 148148224 23:13:45 INFO - PROCESS | 20946 | 23:13:49 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58257/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:49 INFO - PROCESS | 20946 | RSS: Main: 149110784 23:13:49 INFO - PROCESS | 20946 | 23:13:52 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58257/tests/kraken/driver.html?testName=json-parse-financial) 23:13:53 INFO - PROCESS | 20946 | RSS: Main: 149512192 23:13:53 INFO - PROCESS | 20946 | 23:13:54 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:55 INFO - PROCESS | 20946 | RSS: Main: 148471808 23:13:55 INFO - PROCESS | 20946 | 23:13:57 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:57 INFO - PROCESS | 20946 | RSS: Main: 148783104 23:13:57 INFO - PROCESS | 20946 | 23:14:00 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:00 INFO - PROCESS | 20946 | RSS: Main: 149807104 23:14:00 INFO - PROCESS | 20946 | 23:14:03 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:03 INFO - PROCESS | 20946 | RSS: Main: 156852224 23:14:03 INFO - PROCESS | 20946 | 23:14:06 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:06 INFO - PROCESS | 20946 | RSS: Main: 148410368 23:14:06 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:58257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58257/tests/kraken/driver.html?testName=ai-astar) 23:14:08 INFO - PROCESS | 20946 | RSS: Main: 149594112 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | __start_tp_report 23:14:08 INFO - PROCESS | 20946 | _x_x_mozilla_page_load 23:14:08 INFO - PROCESS | 20946 | _x_x_mozilla_page_load_details 23:14:08 INFO - PROCESS | 20946 | |i|pagename|runs| 23:14:08 INFO - PROCESS | 20946 | |0;ai-astar;111;107;111;109;111;123;110;110;111;110 23:14:08 INFO - PROCESS | 20946 | |1;audio-beat-detection;148;125;152;167;134;159;152;126;161;131 23:14:08 INFO - PROCESS | 20946 | |2;audio-dft;162;162;163;162;162;163;164;163;171;164 23:14:08 INFO - PROCESS | 20946 | |3;audio-fft;75;71;79;76;75;72;137;71;75;72 23:14:08 INFO - PROCESS | 20946 | |4;audio-oscillator;97;96;139;96;96;97;136;95;97;141 23:14:08 INFO - PROCESS | 20946 | |5;imaging-gaussian-blur;109;110;110;109;110;109;110;110;110;109 23:14:08 INFO - PROCESS | 20946 | |6;imaging-darkroom;145;151;146;145;147;147;147;147;147;146 23:14:08 INFO - PROCESS | 20946 | |7;imaging-desaturate;96;98;96;96;96;96;96;96;96;96 23:14:08 INFO - PROCESS | 20946 | |8;json-parse-financial;59;62;61;60;61;62;59;59;58;61 23:14:08 INFO - PROCESS | 20946 | |9;json-stringify-tinderbox;69;69;70;69;69;69;69;68;70;69 23:14:08 INFO - PROCESS | 20946 | |10;stanford-crypto-aes;86;88;87;89;95;86;95;88;89;90 23:14:08 INFO - PROCESS | 20946 | |11;stanford-crypto-ccm;117;132;120;116;131;122;128;121;127;121 23:14:08 INFO - PROCESS | 20946 | |12;stanford-crypto-pbkdf2;141;145;150;150;161;138;147;156;153;143 23:14:08 INFO - PROCESS | 20946 | |13;stanford-crypto-sha256-iterative;68;68;68;69;68;79;67;68;71;68 23:14:08 INFO - PROCESS | 20946 | __end_tp_report 23:14:08 INFO - PROCESS | 20946 | __start_cc_report 23:14:08 INFO - PROCESS | 20946 | _x_x_mozilla_cycle_collect,704 23:14:08 INFO - PROCESS | 20946 | __end_cc_report 23:14:08 INFO - PROCESS | 20946 | __startTimestamp1451632448868__endTimestamp 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | ------- Summary: start ------- 23:14:08 INFO - PROCESS | 20946 | Number of tests: 14 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.30 (3.9%) stddev-sans-first:4.56 23:14:08 INFO - PROCESS | 20946 | Values: 111.0 107.0 111.0 109.0 111.0 123.0 110.0 110.0 111.0 110.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:152.00 stddev:15.34 (10.1%) stddev-sans-first:16.25 23:14:08 INFO - PROCESS | 20946 | Values: 148.0 125.0 152.0 167.0 134.0 159.0 152.0 126.0 161.0 131.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.72 (1.7%) stddev-sans-first:2.82 23:14:08 INFO - PROCESS | 20946 | Values: 162.0 162.0 163.0 162.0 162.0 163.0 164.0 163.0 171.0 164.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:20.08 (26.8%) stddev-sans-first:21.21 23:14:08 INFO - PROCESS | 20946 | Values: 75.0 71.0 79.0 76.0 75.0 72.0 137.0 71.0 75.0 72.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:96.00 stddev:20.52 (21.4%) stddev-sans-first:21.30 23:14:08 INFO - PROCESS | 20946 | Values: 97.0 96.0 139.0 96.0 96.0 97.0 136.0 95.0 97.0 141.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:14:08 INFO - PROCESS | 20946 | Values: 109.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.69 (1.1%) stddev-sans-first:1.66 23:14:08 INFO - PROCESS | 20946 | Values: 145.0 151.0 146.0 145.0 147.0 147.0 147.0 147.0 147.0 146.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 23:14:08 INFO - PROCESS | 20946 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:61.00 stddev:1.40 (2.3%) stddev-sans-first:1.41 23:14:08 INFO - PROCESS | 20946 | Values: 59.0 62.0 61.0 60.0 61.0 62.0 59.0 59.0 58.0 61.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 23:14:08 INFO - PROCESS | 20946 | Values: 69.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 70.0 69.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:89.00 stddev:3.27 (3.7%) stddev-sans-first:3.24 23:14:08 INFO - PROCESS | 20946 | Values: 86.0 88.0 87.0 89.0 95.0 86.0 95.0 88.0 89.0 90.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.50 stddev:5.64 (4.5%) stddev-sans-first:5.47 23:14:08 INFO - PROCESS | 20946 | Values: 117.0 132.0 120.0 116.0 131.0 122.0 128.0 121.0 127.0 121.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:150.00 stddev:7.06 (4.7%) stddev-sans-first:6.96 23:14:08 INFO - PROCESS | 20946 | Values: 141.0 145.0 150.0 150.0 161.0 138.0 147.0 156.0 153.0 143.0 23:14:08 INFO - PROCESS | 20946 | 23:14:08 INFO - PROCESS | 20946 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:68.00 stddev:3.53 (5.2%) stddev-sans-first:3.71 23:14:08 INFO - PROCESS | 20946 | Values: 68.0 68.0 68.0 69.0 68.0 79.0 67.0 68.0 71.0 68.0 23:14:08 INFO - PROCESS | 20946 | -------- Summary: end -------- 23:14:08 INFO - PROCESS | 20946 | 23:14:10 INFO - TEST-INFO | 20946: exit 0 23:14:10 INFO - TEST-OK | kraken | took 73115ms 23:14:10 INFO - TEST-START | v8_7 23:14:10 INFO - operating with platform_type : linux_ 23:14:10 INFO - Initialising browser for v8_7 test... 23:14:10 INFO - TEST-INFO | started process 21240 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSSthrX/profile http://localhost:58257/getInfo.html) 23:14:25 INFO - PROCESS | 21240 | __metrics Screen width/height:1600/1200 23:14:25 INFO - PROCESS | 21240 | colorDepth:24 23:14:25 INFO - PROCESS | 21240 | Browser inner width/height: 1024/697 23:14:25 INFO - PROCESS | 21240 | __metrics 23:14:25 INFO - PROCESS | 21240 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:14:26 INFO - PROCESS | 21240 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 23:14:29 INFO - TEST-INFO | 21240: exit 0 23:14:29 INFO - Browser initialized. 23:14:29 INFO - Running cycle 1/1 for v8_7 test... 23:14:29 INFO - TEST-INFO | started process 21361 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSSthrX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:41 INFO - PROCESS | 21361 | RSS: Main: 150073344 23:14:41 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | Cycle 1(1): loaded http://localhost:58257/tests/v8_7/run.html (next: http://localhost:58257/tests/v8_7/run.html) 23:15:02 INFO - PROCESS | 21361 | RSS: Main: 146841600 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | __start_tp_report 23:15:02 INFO - PROCESS | 21361 | _x_x_mozilla_page_load 23:15:02 INFO - PROCESS | 21361 | _x_x_mozilla_page_load_details 23:15:02 INFO - PROCESS | 21361 | |i|pagename|runs| 23:15:02 INFO - PROCESS | 21361 | |0;Richards;167.000668002672 23:15:02 INFO - PROCESS | 21361 | |1;DeltaBlue;189.3939393939394 23:15:02 INFO - PROCESS | 21361 | |2;Encrypt;283.2058906825262 23:15:02 INFO - PROCESS | 21361 | |3;Decrypt;5240.837696335078 23:15:02 INFO - PROCESS | 21361 | |4;RayTrace;1053.740779768177 23:15:02 INFO - PROCESS | 21361 | |5;Earley;713.7758743754462 23:15:02 INFO - PROCESS | 21361 | |6;Boyer;12512.5 23:15:02 INFO - PROCESS | 21361 | |7;RegExp;25500 23:15:02 INFO - PROCESS | 21361 | |8;Splay;693.4812760055479 23:15:02 INFO - PROCESS | 21361 | |9;NavierStokes;4826.923076923077 23:15:02 INFO - PROCESS | 21361 | __end_tp_report 23:15:02 INFO - PROCESS | 21361 | __startTimestamp1451632502672__endTimestamp 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | ------- Summary: start ------- 23:15:02 INFO - PROCESS | 21361 | Number of tests: 10 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#0] Richards Cycles:1 Average:167.00 Median:167.00 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 167.0 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#1] DeltaBlue Cycles:1 Average:189.39 Median:189.39 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 189.4 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#2] Encrypt Cycles:1 Average:283.21 Median:283.21 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 283.2 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 5240.8 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 1053.7 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 713.8 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 12512.5 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 25500.0 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#8] Splay Cycles:1 Average:693.48 Median:693.48 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 693.5 23:15:02 INFO - PROCESS | 21361 | 23:15:02 INFO - PROCESS | 21361 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 23:15:02 INFO - PROCESS | 21361 | Values: 4826.9 23:15:02 INFO - PROCESS | 21361 | -------- Summary: end -------- 23:15:02 INFO - PROCESS | 21361 | 23:15:04 INFO - TEST-INFO | 21361: exit 0 23:15:04 INFO - TEST-OK | v8_7 | took 53699ms 23:15:04 INFO - SUITE-END | took 1297s 23:15:04 INFO - Completed test suite (00:21:37) 23:15:04 INFO - Working with test: dromaeo_css 23:15:04 INFO - Generating results file: dromaeo_css 23:15:04 INFO - Working with test: kraken 23:15:04 INFO - Generating results file: kraken 23:15:04 INFO - javascript benchmark 23:15:04 INFO - Working with test: v8_7 23:15:04 INFO - Generating results file: v8_7 23:15:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:15:06 INFO - process_Request line: dromaeo_css 7046.05 graph.html#tests=[[72,64,43]] 23:15:06 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:06 INFO - process_Request line: kraken 1522.20 graph.html#tests=[[232,64,43]] 23:15:06 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:07 INFO - process_Request line: v8_7 20982.86 graph.html#tests=[[230,64,43]] 23:15:07 INFO - RETURN: dromaeo_css: 7046.05 23:15:07 INFO - RETURN: kraken: 1522.20 23:15:07 INFO - RETURN: v8_7: 20982.86 23:15:07 INFO - javascript benchmark 23:15:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3169.6037995250595, 3236.3203727217283, 3247.9188020299503, 3267.0852161394805, 3275.55779969704, 5287.4976877196705, 5348.117560602505, 5351.876106017736, 5361.035013697538, 5394.3796463406625, 5310.0, 5311.973440132803, 5390.4879036491475, 5447.564194864412, 5470.91793623095, 4874.731889746063, 4916.090523253191, 4972.87567810804, 5001.524855138774, 5010.924836127461, 4972.453030166696, 4985.6260780441435, 5041.495850414965, 5045.596352291826, 5077.898442031157, 4852.733099679516, 4891.315215869781, 4939.086269040203, 4974.676646018033, 5030.723310217936, 4891.339669144655, 4913.828016019458, 4930.654854160211, 4934.629902757308, 4948.777305021283, 4881.8535443936735, 4911.263310503417, 4917.311576379309, 4917.8278760243575, 4924.729139897304, 5094.0, 5191.377034755816, 5201.895962080737, 5280.841574752763, 5342.519173274424, 5779.479846813807, 5791.131330300489, 5795.82612521625, 5801.24583804107, 5812.912806307909, 5788.247527821356, 5839.970800146015, 5841.065429531254, 5844.064949608085, 5850.473457388813, 5344.171653393731, 5395.514403703646, 5412.810551630674, 5440.238366628675, 5453.618246722692, 5968.22413086296, 5983.37174596661, 5986.850328741816, 6009.729562169713, 6028.306744724413, 5760.683162426107, 5762.538996880239, 5762.94237057624, 5767.307923049261, 5774.105013722879, 5612.747426365823, 5680.97159514208, 5827.679477628772, 5845.357010728816, 5958.0, 5726.169705392695, 5751.396103409082, 5753.367129615739, 5759.049756790167, 5766.04860198071, 5727.39862314451, 5735.799247026334, 5748.798792042258, 5754.482096611241, 5764.913526297109, 4344.522102568715, 4413.58070983256, 4445.044315472189, 4463.910721785546, 4477.194105061055, 3932.941005884914, 3944.5463771666628, 3961.3067713150085, 4005.319095753729, 4022.6580740637373, 5285.973570132125, 5398.541124004503, 5418.864528386822, 5425.782968681208, 5438.265834112423, 5737.139429085671, 5819.185314056035, 5826.155207494974, 5852.473277405054, 5887.175795388649, 5433.646812957145, 5434.456554344534, 5437.972810136003, 5438.592105592017, 5441.673499589958, 4891.779869905863, 4939.90120197594, 4956.702597844141, 4963.329950456714, 5006.048850718352, 5870.970645146747, 5937.109433584997, 5951.5238780897425, 5956.076808094752, 5977.312609049928, 5673.234113394639, 5750.396208398225, 5750.827475175752, 5753.0, 5771.134329850556, 5894.911576326444, 5920.940790592212, 5922.73347699346, 5938.703064846654, 6036.9698151508965, 5707.857303567444, 5795.39148389413, 5796.565257605612, 5798.913016304843, 5854.619449735754, 5848.912266315923, 5870.0, 5902.1441890926435, 5903.881922361615, 5917.644941303535, 5600.915986260128, 5697.173909783141, 5735.11105778605, 5749.195112684144, 5758.1650660654805, 5592.580556458201, 5627.662340259598, 5670.5180059695385, 5727.083666613322, 5751.827445176651, 5605.243292155506, 5607.523360514402, 5627.746751396279, 5643.3792282848035, 5646.689432081275, 5562.638428502134, 5680.517156041783, 5689.260396148474, 5726.2269593606, 5736.6558006519745, 5460.972695136499, 5518.86202844916, 5520.641158324696, 5525.309336332958, 5567.053600887778], "unit": "score", "name": "dojo.html", "value": 5341.133298353094}, {"lowerIsBetter": false, "replicates": [545.5117669685629, 556.4796914884582, 563.7322271920838, 567.8580354911272, 573.1631817546382, 34695.65304346956, 35569.2886142277, 35918.28163436736, 35943.0, 36046.819765901164, 39455.0, 39908.201835963264, 40112.79943600285, 40207.798961005225, 40296.395554066716, 8494.362922780785, 8504.744857654281, 8628.223459888608, 8634.0, 8636.827263454727, 8232.382571307146, 8336.749897503085, 8361.83276334473, 8634.870476942819, 8640.697575584856, 8655.913440865605, 8696.912885889264, 8718.38971272008, 8725.520096394695, 8756.168164024408, 8697.434666746673, 8804.03155652881, 8814.33892458065, 8814.427062240933, 8816.294696424271, 8546.2308392245, 8738.781530461725, 8760.78098047554, 8770.298376129895, 8785.0, 39844.20311593781, 40274.0, 40409.0, 40451.0, 40468.595314046775, 3341.2649217172425, 3361.6302206757236, 3439.7592168548213, 3460.9271125950786, 3566.696830769388, 29454.852725736448, 29624.40751184986, 29672.70327296721, 29862.0, 30050.398992020037, 3415.9146021349416, 3485.7559970802054, 3565.536480257576, 3584.802835844054, 3724.7206459515646, 273351.0, 274903.0, 275425.0, 275748.0, 276088.0, 41461.0, 41894.58105418968, 42209.788951055045, 54787.0, 55185.44814551803, 40221.0, 40385.0, 40405.1918961625, 40482.79758601188, 40524.0, 14093.2248726319, 14130.15219086858, 14211.50259740904, 14283.928580357031, 14315.78526322106, 11371.943140284246, 11375.943120284346, 11402.315861048364, 11524.423778811026, 11531.654050378502, 14196.64508387278, 14347.56957291283, 14396.496122635657, 14438.783418248735, 14465.78301325481, 5703.0, 5814.622049566765, 5820.534357251409, 5959.28488581373, 5997.160397544348, 942.8962814090445, 983.8524221366853, 997.6258902911409, 1026.1175389165312, 1096.17786660005, 27932.720672793417, 28202.576961345596, 28616.570751438747, 28819.855900720362, 28881.85559072233, 1081.4754843900703, 1084.749145523043, 1126.8873112688666, 1161.517970042423, 1189.1141099880472, 14846.257687115602, 14848.554543363716, 14976.47582334613, 15078.924605377122, 15083.773743393858, 299872.0, 300749.0, 300922.0, 302191.0, 303535.0, 51704.0, 51762.22356664653, 51769.22346164811, 51775.74112129415, 51956.74021629943, 1356.9728605428033, 1361.2309045389322, 1383.4397069187196, 1394.9163050217019, 1405.3605609447677, 26393.0, 27679.0, 27748.819310827195, 28118.156455306373, 28418.57372139461, 45926.54073459223, 46170.76914615405, 46201.306980395995, 46348.07303853972, 46526.76736616295, 283223.0, 285555.0, 286034.0, 286058.0, 286717.0, 32534.511982320757, 42764.0, 42788.57211427846, 43738.56261437345, 43819.0, 38871.60464281454, 38982.0, 39476.605233947295, 39508.802455987534, 39720.205595888496, 34577.48133778045, 35856.28287434289, 36111.0972225686, 36995.44506832346, 37085.25829483341, 36416.45375319319, 36504.0, 37006.44490332701, 37292.627073728916, 37394.0, 35389.46915796317, 35928.0, 36225.27549449049, 36237.275254494234, 36254.637453625124, 30134.547981780728, 33140.0, 33658.475614328534, 33669.49495757517, 33710.0, 25296.873515632305, 25580.10469633554, 25594.488110238064, 25710.611060707033, 25920.0], "unit": "score", "name": "ext.html", "value": 17791.720836445045}, {"lowerIsBetter": false, "replicates": [336.99494507582403, 342.20778896853795, 345.45590694655925, 346.0586111912173, 350.1142110460534, 11512.712182195428, 11783.351915644636, 16370.18149092545, 16876.83123168768, 18296.0, 16355.59111022225, 16478.176091195422, 18031.647626428006, 18422.0, 18427.249411305904, 5691.117876729114, 5864.149698293766, 5909.704514774266, 5927.081302398114, 5928.911066334009, 5814.331351894522, 5832.300123985127, 5870.88258234835, 5887.793927212549, 6216.0, 6296.968515157418, 6400.871982560346, 6405.455536279399, 6412.967935160318, 6488.124103246072, 6424.13274207983, 6443.29123796382, 6444.806655800334, 6450.838729031765, 6873.140857392826, 6552.148220731322, 6571.57284776488, 6596.835079123012, 6620.0, 6626.56927299724, 20891.477713057142, 22018.0, 22660.20689275884, 22996.54006919869, 23031.884840575858, 1929.0547631660525, 2076.1280262289874, 2195.8243340532877, 2209.9668504972437, 2243.921462748796, 13836.446542138303, 14039.438422463089, 14128.717425651532, 14322.355494002795, 14443.494477693335, 1923.1249781349452, 1966.3216190414284, 1989.3634037108131, 1995.820376166152, 2004.6291436084225, 63823.0, 65090.0, 70202.64898675474, 72996.63501682457, 74195.62902185509, 15546.989445685995, 15599.064056156667, 15653.686926261411, 15724.528264152093, 15727.528174154793, 23763.0, 24058.759412405652, 24340.7565924342, 24493.877530612233, 24523.632145517833, 8758.737237882873, 8813.25087367568, 8819.559022048872, 8846.46921184731, 8876.245519130816, 7385.4460915431555, 7398.297161769623, 7440.85118297631, 7443.739469118555, 7468.589227592426, 7682.270184332479, 7785.688572457038, 7845.333146682482, 7871.921280787234, 8025.23760242776, 1753.587906841891, 3022.637283525947, 3055.541668749661, 3090.9027295309843, 3188.6333071696586, 764.5298141642961, 894.0433735902521, 917.1699611851285, 990.8365119755304, 1034.6999370182714, 16093.034417934961, 16704.41534546285, 16707.331706731595, 17110.315587376364, 17250.568735781453, 925.9537023148815, 959.5969692728931, 969.0, 970.4177493503983, 1016.4460369098858, 9248.537573121317, 9354.029147769561, 9362.719118426457, 9673.419594824332, 9676.322657414054, 539399.0, 543470.0, 546542.0, 546803.0, 547240.0, 31971.0, 32054.519182212287, 43663.0, 75367.0, 78240.60879695565, 1161.6224726963771, 1163.1741463560966, 1167.0663469224587, 1168.3982748884332, 1178.0869825885009, 14774.926125369304, 15100.773488397903, 15173.0, 15181.392744290546, 15406.614834629225, 33407.49888751622, 33420.66579334175, 33884.32231355408, 34254.14364640904, 34332.97001089971, 44888.55111448844, 45124.09751805011, 45232.32151517796, 45269.77365113285, 49603.75198123986, 9596.18432433251, 9706.805863882542, 9756.170725488413, 9821.214302855897, 9825.312228143961, 16509.17454127265, 16529.19003769338, 17209.483715488554, 17341.219645116253, 17350.219240134476, 13744.725105498033, 13908.165510069428, 13925.164490130624, 14308.785368219276, 14664.926675366982, 13446.663833403853, 13552.0, 13622.0, 14155.575332740034, 14328.426862925366, 13453.596392108253, 13778.517751878637, 14114.858851411765, 14606.196659183846, 15321.387144514094, 9058.773530661787, 9525.618975240914, 9771.511424428892, 9778.16885564735, 9832.55753491109, 13539.390727417092, 13649.727005460034, 14729.26353682333, 15001.0, 15032.0], "unit": "score", "name": "jquery.html", "value": 9680.177843186526}, {"lowerIsBetter": false, "replicates": [1452.1650051220547, 1464.0849469081825, 1620.6191544986925, 1756.1833747307498, 1767.3019157432807, 6638.8008359749165, 6760.256371799098, 7334.633268336582, 7475.364594009509, 7501.174870764212, 7083.1854336751285, 7150.249223831488, 7236.638168091601, 7242.674079666414, 7258.673359698813, 2251.752307246206, 2302.159711705224, 2317.4669825940045, 2321.315212012452, 2322.7909488146065, 2225.432514708755, 2257.6500642400374, 2259.243153543565, 2267.0, 2267.263139479676, 2228.2980861028805, 2251.7410497792716, 2271.4548508357957, 2287.0165828693657, 2303.7465878753324, 2225.643896976476, 2239.1826983151195, 2261.7625149359246, 2262.9207977720785, 2264.637657974716, 2297.4715815362392, 2310.8151347892294, 2320.3271051395077, 2323.3494621506006, 2324.140068174786, 7380.963095184544, 7432.739854105081, 7445.85108297831, 7462.216467270912, 7475.401967842559, 4591.242444996572, 4614.984703365254, 4634.86095417138, 4655.674102812804, 4663.766811659403, 3052.938941221163, 3079.230192451887, 3136.6549679535233, 3146.3078122812944, 3187.15540381799, 996.9900300996969, 1003.6336737090983, 1854.2119599170298, 1857.8606604504716, 1868.5795695968434, 9731.951340243324, 9850.655227067018, 9860.359076660066, 9878.259130565237, 9901.504924753734, 3926.1362500249897, 3988.142549351903, 4020.3366444536323, 4055.9797201013807, 4062.289099407592, 8367.581620918929, 8430.789230269293, 8460.534670593177, 8466.32269418445, 8480.406371554056, 4519.932201016987, 4531.977340113344, 4543.5910768031035, 4547.272436410159, 4559.726416415026, 4118.19695159441, 4213.304804707189, 4227.027783609787, 4251.362295655615, 4262.616364527207, 3553.3603951289015, 3562.98218508911, 3563.3051554947056, 3570.839312230956, 3606.6213047630145, 1091.170710260208, 1093.1691914145306, 1095.2606990281529, 1107.6510899066768, 1109.2013750099916, 1013.1793247469426, 1048.8374301983206, 1152.9423528823525, 1159.263867444162, 1166.9474873630706, 6579.144711187515, 6720.731170753213, 6736.93263067363, 6759.662016899136, 6759.898601520981, 1112.4271000434783, 1139.1968662093204, 1144.9713757156137, 1150.8158694608821, 1163.755611321615, 5592.692401917852, 5609.214709940612, 5626.915596266059, 5634.971825140848, 5642.774289028475, 8351.331893448509, 8810.383273170944, 8818.823623527494, 8897.599608017656, 8935.463872167691, 8699.478031318142, 8772.385932984758, 8821.073787252375, 8880.8667869982, 8894.42186257891, 6667.86664266712, 6757.729690812411, 6775.288594697585, 6812.62530560814, 6978.651067446607, 6747.493937954771, 6754.3921047106, 6756.0, 6761.0534525167495, 6776.898346524707, 7757.92242077572, 8107.756767296991, 8146.75559733209, 8156.9184308156155, 8180.590970451334, 8114.756557303291, 8130.268275855202, 8159.061707903667, 8162.428629995843, 8292.834143316979, 6321.11504389395, 6380.0, 6528.543001990005, 6721.764738234138, 6732.0, 7184.1019872515935, 7217.963910180415, 7237.674304656198, 7238.8914166286495, 7256.310650488195, 6707.698153583198, 6796.150481189851, 6858.279880612663, 6888.104546408935, 6987.895181572382, 6688.632125233159, 6761.763338283333, 6762.8647427052165, 6791.524593278423, 6817.522773405814, 6379.87240255183, 6725.428338591275, 6750.932490675031, 6757.831054223487, 6782.796516104525, 5661.688607126647, 5693.914591281051, 5694.402087780723, 5703.429657034263, 5713.342965559014, 6056.36408177135, 6140.263168419819, 6144.801763656044, 6158.630482171084, 6164.876702466016], "unit": "score", "name": "mootools.html", "value": 4374.789805614849}, {"lowerIsBetter": false, "replicates": [323.68925831202046, 326.5265365220428, 328.64670479234815, 329.97855139415935, 334.63859032245176, 6259.687015649217, 6289.591176573525, 6318.178636777213, 6380.3300653431415, 6494.0583615375745, 6247.468965137958, 6260.2487701475775, 6318.5892916960365, 6342.175517182772, 6360.109584658151, 4774.427068751755, 4778.713277203362, 4781.115493633689, 4782.33047373368, 4783.186858234099, 4733.5976442002475, 4786.56920877121, 4789.425268967729, 4789.544993225638, 4791.496892826255, 4635.281531362644, 4698.90602187956, 4712.599429048535, 4723.48041715411, 4724.149653062447, 4703.976480117594, 4709.293605959099, 4725.881852953669, 4730.432348118248, 4730.597899178557, 4074.979625101885, 4075.9810047488127, 4080.9387859182134, 4082.7754473503946, 4086.244044851712, 5937.228160339171, 5961.433663801975, 5992.250968628921, 5992.880142397127, 6034.728437220336, 5404.135338345845, 5482.698451585161, 5483.314585676791, 5489.58828087891, 5501.559875209973, 6676.833079173011, 6696.86606267872, 6700.698468568926, 6705.6982435790505, 6718.093057437232, 4477.798499067517, 4478.708883922567, 4488.708233964782, 4488.8877778055485, 4498.122866041123, 6835.14560679915, 6920.619365934872, 6941.548799328078, 6978.720851165947, 6981.79054628362, 4544.159330523864, 4551.590356867898, 4554.749488778083, 4556.658250631216, 4565.338025986213, 4620.53794620542, 4624.9768751156025, 4629.976850115728, 4631.536846315342, 4638.072385522909, 5433.972830135824, 5437.809676661298, 5439.184122381595, 5440.727963601804, 5443.863903402446, 6480.351964803576, 6641.966790166115, 6646.8005959821285, 6654.6007239564815, 6724.327567243236, 1600.8393914411959, 1629.372691513752, 1643.3262362431585, 1643.416587111582, 1644.9177541123136, 1049.905508504223, 1064.7817197474499, 1066.5040756048475, 1076.8223243164946, 1086.3373342261214, 6275.623462592259, 6337.176167098248, 6339.334369891095, 6339.492840572835, 6345.143405640272, 6799.606080753434, 6840.0765896603325, 6844.931550684529, 6850.3149685032095, 6855.314468553204, 6186.412290832363, 6325.620462772248, 6331.398517140864, 6334.461570766536, 6340.968295158495, 3690.5940346561856, 3722.441633754904, 3725.0501122214205, 3725.9441108383394, 3733.533308336458, 7064.43484521237, 7070.292970702889, 7114.964425177841, 7118.501704880712, 7154.713811447484, 6900.102986611809, 6999.895001574981, 7006.369426751617, 7010.263922288086, 7027.332403421667, 7174.390176834923, 7184.856302874018, 7188.353048225685, 7199.1001124859395, 7221.747238846615, 6853.657317134223, 6956.40870526011, 6982.860342793014, 6987.196472405739, 7011.193712723102, 6724.966375168093, 6854.074699915447, 6897.206821215625, 6899.379055884994, 6903.722811279929, 7190.784276471714, 7211.819704507429, 7224.2414546473965, 7226.602536860523, 7293.52592081513, 4702.576768090751, 4712.740799256074, 4741.739204343794, 4765.4996225395835, 4767.928481072718, 6848.9657551711925, 6877.415419689382, 6881.41507971828, 6952.652367381509, 6999.370056694922, 6809.5233333666165, 6829.93170068293, 6835.760748373783, 6852.040714299902, 6864.828379290558, 6796.72813087471, 6824.761133360308, 6830.282820303796, 6832.897506537306, 6834.589924604539, 6544.149260596092, 6670.433013193933, 6689.866202676017, 6697.196336439659, 6702.430293425114, 6808.761693340709, 6809.080774095433, 6813.0, 6821.386075253251, 6834.350736680008, 6629.7348106075215, 6629.966850165718, 6631.834204144935, 6633.170853643294, 6660.56706314088], "unit": "score", "name": "prototype.html", "value": 4996.686658559119}, {"lowerIsBetter": false, "replicates": [782.4679218131671, 853.1638993786089, 853.8701839639015, 868.9869651955222, 874.2656168818191, 12814.551490697828, 12967.221966682006, 13055.93472032641, 13081.54214602489, 13115.409806558715, 12617.747645047093, 12703.428345724442, 12704.428300726466, 12720.173188742725, 12725.809112863315, 668.7325069972002, 687.2440315652767, 814.8370325934836, 837.4891316297054, 844.5608283692476, 818.3207937411934, 824.056455358614, 832.2426591801462, 832.7501749475164, 833.1793183714037, 881.497546398553, 887.7114937645259, 888.1873086126187, 890.8307421589877, 892.3218354050903, 862.7023676831483, 877.3025444771422, 879.4898958603994, 880.1418616848554, 881.9470831750116, 632.3076231526517, 634.2769243062912, 635.3519410201615, 646.1180488633029, 651.3649192037773, 12893.097483176181, 12913.935430322883, 12943.870561294361, 12955.352232388343, 13121.147125436815, 11892.345920974343, 12099.274043557327, 12425.0, 12709.364531773466, 12750.80873786894, 9934.354266972623, 10291.845622315672, 10528.631497897613, 10532.526036328383, 10704.839427408595, 3598.1544337080763, 3608.025833025095, 3656.5063716398213, 3720.7023438124884, 3737.682297004758, 49313.50686493125, 49542.7522862387, 50097.0, 50151.74924125393, 50323.74838125786, 9261.814763704822, 9516.23870090391, 9584.808303833885, 9884.064740872584, 9961.103500684972, 17730.113494325233, 17871.463856084338, 17908.0, 17947.551311217325, 18010.36963706264, 6600.768973085919, 6925.168979722465, 7204.0994875640545, 7311.744088956861, 7388.408927285805, 4028.1339512004474, 4064.3700226464944, 4083.4283200351974, 4096.467459230281, 4223.493180818322, 2995.341024974502, 3041.81749095055, 3042.39152169567, 3045.482268014443, 3086.135881953057, 535.8446050645347, 540.1573545269314, 540.1762312473431, 547.1683041776478, 559.6278474814285, 554.4483239176964, 563.1018525451898, 628.8302158417201, 647.145767586781, 651.9047999361119, 7545.396368290523, 7552.244775522404, 7564.773056808304, 7852.175521570267, 7896.881546776803, 556.8607848037991, 619.3247266145066, 644.7825351496094, 694.8957656351588, 709.4187390844382, 3699.648533389324, 3724.42271447926, 3787.981060094682, 3829.636184562518, 3843.3466310727244, 52634.73682631639, 52803.73598131985, 52805.2079218812, 53391.73304133532, 53462.73268633632, 48691.26963095556, 49323.75338123286, 50631.49368506341, 51180.48819511757, 51542.48457515452, 45678.0, 45716.3142552862, 45944.54055459469, 46232.5376746235, 46668.0, 7441.739539116105, 7534.35957943581, 7537.924620753942, 7676.347510461674, 7762.41781866351, 33398.833005834815, 33413.49879751757, 33612.0, 33903.0, 34005.319893602486, 39852.0, 43065.78467107644, 44031.11937761163, 44057.77971110124, 44679.10641787211, 9538.523073846141, 9692.176165026052, 9858.704238872846, 9963.402195868272, 10032.670773374392, 10949.56201751921, 10961.451927403758, 11170.27393219438, 11183.273087249303, 11637.185397022127, 9326.207272381924, 9391.154796068387, 9508.381955172892, 9635.22918166559, 9838.508074596099, 10617.840732388866, 10793.56825726962, 10844.0, 11064.170187235828, 11413.201075924937, 10220.897791021995, 10427.612484557796, 10460.63387781424, 10531.94734026325, 10651.786964260516, 9553.331266811256, 9605.18355939753, 9721.805563888824, 9733.659321923698, 9862.112409883144, 7692.614650984264, 8378.790530236793, 8599.355048371272, 8605.98612131111, 8772.122787721177], "unit": "score", "name": "yui.html", "value": 6085.044866035687}], "name": "dromaeo_css", "value": 7046.0548447101355}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 109.0, 111.0, 123.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 152.0, 167.0, 134.0, 159.0, 152.0, 126.0, 161.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 164.0, 163.0, 171.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 79.0, 76.0, 75.0, 72.0, 137.0, 71.0, 75.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 139.0, 96.0, 96.0, 97.0, 136.0, 95.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 151.0, 146.0, 145.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [59.0, 62.0, 61.0, 60.0, 61.0, 62.0, 59.0, 59.0, 58.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 87.0, 89.0, 95.0, 86.0, 95.0, 88.0, 89.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [117.0, 132.0, 120.0, 116.0, 131.0, 122.0, 128.0, 121.0, 127.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [141.0, 145.0, 150.0, 150.0, 161.0, 138.0, 147.0, 156.0, 153.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 79.0, 67.0, 68.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1522.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.000668002672], "unit": "score", "name": "Richards", "value": 211.38837599999997}, {"lowerIsBetter": false, "replicates": [189.3939393939394], "unit": "score", "name": "DeltaBlue", "value": 349.1030400000001}, {"lowerIsBetter": false, "replicates": [283.2058906825262], "unit": "score", "name": "Encrypt", "value": 939.8851109999996}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1053.740779768177], "unit": "score", "name": "RayTrace", "value": 702.2495610000001}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [25500.0], "unit": "score", "name": "RegExp", "value": 35.72490196078431}, {"lowerIsBetter": false, "replicates": [693.4812760055479], "unit": "score", "name": "Splay", "value": 117.51002199999999}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20982.860718912387}]} 23:15:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20982.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1522.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7046.05"}}} 23:15:07 INFO - Return code: 0 23:15:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:07 INFO - # TBPL SUCCESS # 23:15:07 INFO - Running post-action listener: _resource_record_post_action 23:15:07 INFO - Running post-run listener: _resource_record_post_run 23:15:08 INFO - Total resource usage - Wall time: 1317s; CPU: 14.0%; Read bytes: 8192; Write bytes: 548245504; Read time: 7956; Write time: 6764356 23:15:08 INFO - install - Wall time: 16s; CPU: 28.0%; Read bytes: 0; Write bytes: 128122880; Read time: 0; Write time: 1372080 23:15:08 INFO - run-tests - Wall time: 1302s; CPU: 14.0%; Read bytes: 8192; Write bytes: 420122624; Read time: 7956; Write time: 5392276 23:15:08 INFO - Running post-run listener: _upload_blobber_files 23:15:08 INFO - Blob upload gear active. 23:15:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:15:08 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 23:15:08 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'] 23:15:08 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 23:15:08 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:09 INFO - (blobuploader) - INFO - Done attempting. 23:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:10 INFO - (blobuploader) - INFO - Done attempting. 23:15:10 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:10 INFO - Return code: 0 23:15:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:15:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d85640de6ff7336e5321787dd86c213fc7d4174fe15eda8d8c79a2dcc4d577ab1a54e098773d0c712a06eade3536f96c722f84c3cff42eb52b56ef70a83c535", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cce61d1ab88999196381a8a1ade8108b0f42e9be249f64e3acc239def0a04bdd41d27a282e02d20d4e14666daf7be1cfda04b81854447caa38fb88a7ed57a7"} 23:15:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:15:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:15:10 INFO - Contents: 23:15:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d85640de6ff7336e5321787dd86c213fc7d4174fe15eda8d8c79a2dcc4d577ab1a54e098773d0c712a06eade3536f96c722f84c3cff42eb52b56ef70a83c535", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cce61d1ab88999196381a8a1ade8108b0f42e9be249f64e3acc239def0a04bdd41d27a282e02d20d4e14666daf7be1cfda04b81854447caa38fb88a7ed57a7"} 23:15:10 INFO - Copying logs to upload dir... 23:15:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1362.187106 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 42 secs) (at 2015-12-31 23:15:10.207931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 23:15:10.211478) ========= 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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 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/7d85640de6ff7336e5321787dd86c213fc7d4174fe15eda8d8c79a2dcc4d577ab1a54e098773d0c712a06eade3536f96c722f84c3cff42eb52b56ef70a83c535", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cce61d1ab88999196381a8a1ade8108b0f42e9be249f64e3acc239def0a04bdd41d27a282e02d20d4e14666daf7be1cfda04b81854447caa38fb88a7ed57a7"} build_url:https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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/7d85640de6ff7336e5321787dd86c213fc7d4174fe15eda8d8c79a2dcc4d577ab1a54e098773d0c712a06eade3536f96c722f84c3cff42eb52b56ef70a83c535", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95cce61d1ab88999196381a8a1ade8108b0f42e9be249f64e3acc239def0a04bdd41d27a282e02d20d4e14666daf7be1cfda04b81854447caa38fb88a7ed57a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 23:15:10.237320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 23:15:10.237703) ========= 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=256b35f542ca8bede9e27f1f00000291-1451628829.725230-436028934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 23:15:10.319512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 23:15:10.319920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 23:15:10.320307) ========= ========= Total master_lag: 0.29 =========