builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1452063564.6 results: success (0) buildid: 20160105203052 builduid: d1128ed623b449a38d22b799b1ecc6e7 revision: 1a9729efc3da75a85714f20c1afd471b9e684dfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.602709) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.603231) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.603579) ========= 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=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006447 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.627680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.628110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.644008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.644641) ========= 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=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.705177) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.705486) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.706140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.706500) ========= 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=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 22:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-05 22:59:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098943 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.841526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.841939) ========= 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=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018378 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.898535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:24.899015) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a9729efc3da75a85714f20c1afd471b9e684dfb --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 1a9729efc3da75a85714f20c1afd471b9e684dfb --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=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 22:59:25,422 truncating revision to first 12 chars 2016-01-05 22:59:25,422 Setting DEBUG logging. 2016-01-05 22:59:25,422 attempt 1/10 2016-01-05 22:59:25,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a9729efc3da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 22:59:25,704 unpacking tar archive at: fx-team-1a9729efc3da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:25.475230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:25.475597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:25.490223) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:25.490652) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:25.491358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-05 22:59:25.491718) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:59:26 INFO - MultiFileLogger online at 20160105 22:59:26 in /builds/slave/test-pgo 22:59:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:59:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:59:26 INFO - {'append_to_log': False, 22:59:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:59:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:59:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:59:26 INFO - 'branch': 'Fx-Team', 22:59:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:59:26 INFO - 'config_files': ('talos/linux_config.py',), 22:59:26 INFO - 'default_actions': ('clobber', 22:59:26 INFO - 'read-buildbot-config', 22:59:26 INFO - 'download-and-extract', 22:59:26 INFO - 'populate-webroot', 22:59:26 INFO - 'create-virtualenv', 22:59:26 INFO - 'install', 22:59:26 INFO - 'run-tests'), 22:59:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:59:26 INFO - 'download_minidump_stackwalk': True, 22:59:26 INFO - 'download_symbols': 'ondemand', 22:59:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:59:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:59:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:59:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:59:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:59:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:59:26 INFO - 'installer_path': 'installer.exe', 22:59:26 INFO - 'log_level': 'info', 22:59:26 INFO - 'log_name': 'talos', 22:59:26 INFO - 'log_to_console': True, 22:59:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:59:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:59:26 INFO - 'opt_config_files': (), 22:59:26 INFO - 'pip_index': False, 22:59:26 INFO - 'sps_profile': False, 22:59:26 INFO - 'sps_profile_interval': 0, 22:59:26 INFO - 'suite': 'dromaeojs', 22:59:26 INFO - 'system_bits': '32', 22:59:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:59:26 INFO - 'title': 'talos-linux64-ix-035', 22:59:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:59:26 INFO - 'use_talos_json': True, 22:59:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:59:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:59:26 INFO - 'work_dir': 'build'} 22:59:26 INFO - ##### 22:59:26 INFO - ##### Running clobber step. 22:59:26 INFO - ##### 22:59:26 INFO - Running pre-action listener: _resource_record_pre_action 22:59:26 INFO - Running main action method: clobber 22:59:26 INFO - rmtree: /builds/slave/test-pgo/build 22:59:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:59:27 INFO - Running post-action listener: _resource_record_post_action 22:59:27 INFO - ##### 22:59:27 INFO - ##### Running read-buildbot-config step. 22:59:27 INFO - ##### 22:59:27 INFO - Running pre-action listener: _resource_record_pre_action 22:59:27 INFO - Running main action method: read_buildbot_config 22:59:27 INFO - Using buildbot properties: 22:59:27 INFO - { 22:59:27 INFO - "project": "", 22:59:27 INFO - "product": "firefox", 22:59:27 INFO - "script_repo_revision": "production", 22:59:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:59:27 INFO - "repository": "", 22:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:59:27 INFO - "buildid": "20160105203052", 22:59:27 INFO - "pgo_build": "True", 22:59:27 INFO - "basedir": "/builds/slave/test-pgo", 22:59:27 INFO - "buildnumber": 875, 22:59:27 INFO - "slavename": "talos-linux64-ix-035", 22:59:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:59:27 INFO - "platform": "ubuntu64_hw", 22:59:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:59:27 INFO - "branch": "fx-team", 22:59:27 INFO - "repo_path": "integration/fx-team", 22:59:27 INFO - "revision": "1a9729efc3da75a85714f20c1afd471b9e684dfb", 22:59:27 INFO - "stage_platform": "linux64-pgo", 22:59:27 INFO - "builduid": "d1128ed623b449a38d22b799b1ecc6e7", 22:59:27 INFO - "slavebuilddir": "test" 22:59:27 INFO - } 22:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:59:27 INFO - Running post-action listener: _resource_record_post_action 22:59:27 INFO - ##### 22:59:27 INFO - ##### Running download-and-extract step. 22:59:27 INFO - ##### 22:59:27 INFO - Running pre-action listener: _resource_record_pre_action 22:59:27 INFO - Running main action method: download_and_extract 22:59:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:27 INFO - https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json 22:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json 22:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:59:30 INFO - Downloaded 1302 bytes. 22:59:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:59:30 INFO - Using the following test package requirements: 22:59:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:59:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:59:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:30 INFO - u'jsshell-linux-x86_64.zip'], 22:59:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:59:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:59:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:59:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:59:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:59:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:59:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:59:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:30 INFO - https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:32 INFO - Downloaded 24055577 bytes. 22:59:32 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:59:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59:32 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:59:33 INFO - Return code: 0 22:59:33 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:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:33 INFO - https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:35 INFO - Downloaded 24055577 bytes. 22:59: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:59:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59: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:59:36 INFO - Return code: 0 22:59: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:59:36 INFO - https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:37 INFO - Downloaded 11132285 bytes. 22:59:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:59:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:59:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:59:37 INFO - Return code: 0 22:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:37 INFO - https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/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:59:39 INFO - Downloaded 55062142 bytes. 22:59:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:59:39 INFO - mkdir: /builds/slave/test-pgo/properties 22:59:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:59:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:59:39 INFO - Contents: 22:59:39 INFO - build_url:https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:59:39 INFO - Running post-action listener: _resource_record_post_action 22:59:39 INFO - Running post-action listener: set_extra_try_arguments 22:59:39 INFO - ##### 22:59:39 INFO - ##### Running populate-webroot step. 22:59:39 INFO - ##### 22:59:39 INFO - Running pre-action listener: _resource_record_pre_action 22:59:39 INFO - Running main action method: populate_webroot 22:59:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:59:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:59:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:59:39 INFO - '--tppagecycles', 22:59:39 INFO - '7'], 22:59:39 INFO - 'tests': ['tsvgm']}}, 22:59:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:59:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:59:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:59:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:59:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'tests': ['damp', 'tps']}, 22:59:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['damp', 'tps']}, 22:59:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:59:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:59:39 INFO - 'other': {'tests': ['a11yr', 22:59:39 INFO - 'ts_paint', 22:59:39 INFO - 'tpaint', 22:59:39 INFO - 'sessionrestore', 22:59:39 INFO - 'sessionrestore_no_auto_restore']}, 22:59:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['a11yr', 22:59:39 INFO - 'ts_paint', 22:59:39 INFO - 'tpaint', 22:59:39 INFO - 'sessionrestore', 22:59:39 INFO - 'sessionrestore_no_auto_restore']}, 22:59:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['a11yr', 22:59:39 INFO - 'ts_paint', 22:59:39 INFO - 'tpaint', 22:59:39 INFO - 'sessionrestore', 22:59:39 INFO - 'sessionrestore_no_auto_restore']}, 22:59:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['a11yr', 22:59:39 INFO - 'ts_paint', 22:59:39 INFO - 'tpaint', 22:59:39 INFO - 'sessionrestore', 22:59:39 INFO - 'sessionrestore_no_auto_restore']}, 22:59:39 INFO - 'other_l64': {'tests': ['a11yr', 22:59:39 INFO - 'ts_paint', 22:59:39 INFO - 'tpaint', 22:59:39 INFO - 'sessionrestore', 22:59:39 INFO - 'sessionrestore_no_auto_restore']}, 22:59:39 INFO - 'other_nol64': {'tests': ['a11yr', 22:59:39 INFO - 'ts_paint', 22:59:39 INFO - 'tpaint', 22:59:39 INFO - 'sessionrestore', 22:59:39 INFO - 'sessionrestore_no_auto_restore']}, 22:59:39 INFO - 'svgr': {'tests': ['tsvgx', 22:59:39 INFO - 'tsvgr_opacity', 22:59:39 INFO - 'tart', 22:59:39 INFO - 'tscrollx', 22:59:39 INFO - 'cart']}, 22:59:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['tsvgx', 22:59:39 INFO - 'tsvgr_opacity', 22:59:39 INFO - 'tart', 22:59:39 INFO - 'tscrollx', 22:59:39 INFO - 'cart']}, 22:59:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'tests': ['tp5o']}, 22:59:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'talos_options': ['--e10s'], 22:59:39 INFO - 'tests': ['tp5o']}, 22:59:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'talos_options': ['--xperf_path', 22:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:39 INFO - 'tests': ['tp5n']}, 22:59:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:39 INFO - 'talos_options': ['--e10s', 22:59:39 INFO - '--xperf_path', 22:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:39 INFO - 'tests': ['tp5n']}}, 22:59:39 INFO - 'talos.zip': {'path': '', 22:59:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:59:39 INFO - Running post-action listener: _resource_record_post_action 22:59:39 INFO - ##### 22:59:39 INFO - ##### Running create-virtualenv step. 22:59:39 INFO - ##### 22:59:39 INFO - Running pre-action listener: _resource_record_pre_action 22:59:39 INFO - Running main action method: create_virtualenv 22:59:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:59:39 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:59:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:59:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:59:39 INFO - Using real prefix '/usr' 22:59:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:59:39 INFO - Installing distribute.............................................................................................................................................................................................done. 22:59:41 INFO - Installing pip.................done. 22:59:41 INFO - Return code: 0 22:59:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 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 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:41 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:59:41 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:59:41 INFO - Using env: {'DISPLAY': ':0', 22:59:41 INFO - 'HOME': '/home/cltbld', 22:59:41 INFO - 'LANG': 'en_US.UTF-8', 22:59:41 INFO - 'LANGUAGE': 'en_US:en', 22:59:41 INFO - 'LOGNAME': 'cltbld', 22:59:41 INFO - 'MAIL': '/var/mail/cltbld', 22:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:41 INFO - 'MOZ_NO_REMOTE': '1', 22:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:41 INFO - 'NO_EM_RESTART': '1', 22:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:41 INFO - 'SHELL': '/bin/bash', 22:59:41 INFO - 'SHLVL': '1', 22:59:41 INFO - 'TERM': 'linux', 22:59:41 INFO - 'TMOUT': '86400', 22:59:41 INFO - 'USER': 'cltbld', 22:59:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:41 INFO - '_': '/tools/buildbot/bin/python'} 22:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:41 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:59:41 INFO - Cleaning up... 22:59:41 INFO - Return code: 0 22:59:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 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 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:41 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:59:41 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:59:41 INFO - Using env: {'DISPLAY': ':0', 22:59:41 INFO - 'HOME': '/home/cltbld', 22:59:41 INFO - 'LANG': 'en_US.UTF-8', 22:59:41 INFO - 'LANGUAGE': 'en_US:en', 22:59:41 INFO - 'LOGNAME': 'cltbld', 22:59:41 INFO - 'MAIL': '/var/mail/cltbld', 22:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:41 INFO - 'MOZ_NO_REMOTE': '1', 22:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:41 INFO - 'NO_EM_RESTART': '1', 22:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:41 INFO - 'SHELL': '/bin/bash', 22:59:41 INFO - 'SHLVL': '1', 22:59:41 INFO - 'TERM': 'linux', 22:59:41 INFO - 'TMOUT': '86400', 22:59:41 INFO - 'USER': 'cltbld', 22:59:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:41 INFO - '_': '/tools/buildbot/bin/python'} 22:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:42 INFO - Downloading/unpacking psutil>=0.7.1 22:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:59:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:59:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:43 INFO - Installing collected packages: psutil 22:59:43 INFO - Running setup.py install for psutil 22:59:43 INFO - building 'psutil._psutil_linux' extension 22:59:43 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:59:44 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:59:44 INFO - building 'psutil._psutil_posix' extension 22:59:44 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:59:44 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:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:44 INFO - Successfully installed psutil 22:59:44 INFO - Cleaning up... 22:59:44 INFO - Return code: 0 22:59:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:59:44 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:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:44 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:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:44 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 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:44 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:59:44 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:59:44 INFO - Using env: {'DISPLAY': ':0', 22:59:44 INFO - 'HOME': '/home/cltbld', 22:59:44 INFO - 'LANG': 'en_US.UTF-8', 22:59:44 INFO - 'LANGUAGE': 'en_US:en', 22:59:44 INFO - 'LOGNAME': 'cltbld', 22:59:44 INFO - 'MAIL': '/var/mail/cltbld', 22:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:44 INFO - 'MOZ_NO_REMOTE': '1', 22:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:44 INFO - 'NO_EM_RESTART': '1', 22:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:44 INFO - 'SHELL': '/bin/bash', 22:59:44 INFO - 'SHLVL': '1', 22:59:44 INFO - 'TERM': 'linux', 22:59:44 INFO - 'TMOUT': '86400', 22:59:44 INFO - 'USER': 'cltbld', 22:59:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:44 INFO - '_': '/tools/buildbot/bin/python'} 22:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:59:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:59:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:59:46 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:59:46 INFO - Installing collected packages: mozsystemmonitor 22:59:46 INFO - Running setup.py install for mozsystemmonitor 22:59:46 INFO - Successfully installed mozsystemmonitor 22:59:46 INFO - Cleaning up... 22:59:46 INFO - Return code: 0 22:59:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:59: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:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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', '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 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:59: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 blobuploader==1.2.4 22:59:46 INFO - Using env: {'DISPLAY': ':0', 22:59:46 INFO - 'HOME': '/home/cltbld', 22:59:46 INFO - 'LANG': 'en_US.UTF-8', 22:59:46 INFO - 'LANGUAGE': 'en_US:en', 22:59:46 INFO - 'LOGNAME': 'cltbld', 22:59:46 INFO - 'MAIL': '/var/mail/cltbld', 22:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:46 INFO - 'MOZ_NO_REMOTE': '1', 22:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:46 INFO - 'NO_EM_RESTART': '1', 22:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:46 INFO - 'SHELL': '/bin/bash', 22:59:46 INFO - 'SHLVL': '1', 22:59:46 INFO - 'TERM': 'linux', 22:59:46 INFO - 'TMOUT': '86400', 22:59:46 INFO - 'USER': 'cltbld', 22:59:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:46 INFO - '_': '/tools/buildbot/bin/python'} 22:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:59:46 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:59:46 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:59:46 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:59:46 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:59:46 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:59:46 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:59:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:59:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:59:48 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:59:48 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:59:48 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:59:48 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:59:48 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:59:48 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:59:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:59:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:59:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:49 INFO - Downloading docopt-0.6.1.tar.gz 22:59:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:59:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:59:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:59:49 INFO - Running setup.py install for blobuploader 22:59:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:59:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:59:49 INFO - Running setup.py install for requests 22:59:49 INFO - Running setup.py install for docopt 22:59:49 INFO - Successfully installed blobuploader requests docopt 22:59:49 INFO - Cleaning up... 22:59:50 INFO - Return code: 0 22:59:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59: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:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:50 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 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:50 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:59:50 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:59:50 INFO - Using env: {'DISPLAY': ':0', 22:59:50 INFO - 'HOME': '/home/cltbld', 22:59:50 INFO - 'LANG': 'en_US.UTF-8', 22:59:50 INFO - 'LANGUAGE': 'en_US:en', 22:59:50 INFO - 'LOGNAME': 'cltbld', 22:59:50 INFO - 'MAIL': '/var/mail/cltbld', 22:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:50 INFO - 'MOZ_NO_REMOTE': '1', 22:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:50 INFO - 'NO_EM_RESTART': '1', 22:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:50 INFO - 'SHELL': '/bin/bash', 22:59:50 INFO - 'SHLVL': '1', 22:59:50 INFO - 'TERM': 'linux', 22:59:50 INFO - 'TMOUT': '86400', 22:59:50 INFO - 'USER': 'cltbld', 22:59:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:50 INFO - '_': '/tools/buildbot/bin/python'} 22:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:50 INFO - Running setup.py (path:/tmp/pip-X2pQz5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:50 INFO - Running setup.py (path:/tmp/pip-Z9gdzq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:50 INFO - Running setup.py (path:/tmp/pip-mRbGB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:50 INFO - Running setup.py (path:/tmp/pip-sQKgiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:50 INFO - Running setup.py (path:/tmp/pip-SnEIYe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:50 INFO - Running setup.py (path:/tmp/pip-awoc3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:50 INFO - Running setup.py (path:/tmp/pip-zmyN5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:50 INFO - Running setup.py (path:/tmp/pip-oJiiHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:50 INFO - Running setup.py (path:/tmp/pip-ZmFey9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:50 INFO - Running setup.py (path:/tmp/pip-WvkEbl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:51 INFO - Running setup.py (path:/tmp/pip-vKuyG1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:51 INFO - Running setup.py (path:/tmp/pip-yo0gLT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:51 INFO - Running setup.py (path:/tmp/pip-oZySDx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:51 INFO - Running setup.py (path:/tmp/pip-_nwMq8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:51 INFO - Running setup.py (path:/tmp/pip-zZK84A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:51 INFO - Running setup.py (path:/tmp/pip-M2LXwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:51 INFO - Running setup.py (path:/tmp/pip-h0sqWA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:59:51 INFO - Running setup.py install for manifestparser 22:59:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:59:51 INFO - Running setup.py install for mozcrash 22:59:51 INFO - Running setup.py install for mozdebug 22:59:51 INFO - Running setup.py install for mozdevice 22:59:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:59:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:59:51 INFO - Running setup.py install for mozfile 22:59:52 INFO - Running setup.py install for mozhttpd 22:59:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Running setup.py install for mozinfo 22:59:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Running setup.py install for mozInstall 22:59:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Running setup.py install for mozleak 22:59:52 INFO - Running setup.py install for mozlog 22:59:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Running setup.py install for moznetwork 22:59:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Running setup.py install for mozprocess 22:59:52 INFO - Running setup.py install for mozprofile 22:59:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Running setup.py install for mozrunner 22:59:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:59:52 INFO - Running setup.py install for mozscreenshot 22:59:53 INFO - Running setup.py install for moztest 22:59:53 INFO - Running setup.py install for mozversion 22:59:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:59:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:53 INFO - Cleaning up... 22:59:53 INFO - Return code: 0 22:59:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:53 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 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:53 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:59:53 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:59:53 INFO - Using env: {'DISPLAY': ':0', 22:59:53 INFO - 'HOME': '/home/cltbld', 22:59:53 INFO - 'LANG': 'en_US.UTF-8', 22:59:53 INFO - 'LANGUAGE': 'en_US:en', 22:59:53 INFO - 'LOGNAME': 'cltbld', 22:59:53 INFO - 'MAIL': '/var/mail/cltbld', 22:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:53 INFO - 'MOZ_NO_REMOTE': '1', 22:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:53 INFO - 'NO_EM_RESTART': '1', 22:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:53 INFO - 'SHELL': '/bin/bash', 22:59:53 INFO - 'SHLVL': '1', 22:59:53 INFO - 'TERM': 'linux', 22:59:53 INFO - 'TMOUT': '86400', 22:59:53 INFO - 'USER': 'cltbld', 22:59:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:53 INFO - '_': '/tools/buildbot/bin/python'} 22:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:53 INFO - Running setup.py (path:/tmp/pip-_4Wsh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:53 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:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:53 INFO - Running setup.py (path:/tmp/pip-hSJsIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:53 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:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:53 INFO - Running setup.py (path:/tmp/pip-1SI72s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:53 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:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:53 INFO - Running setup.py (path:/tmp/pip-rSEziu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:53 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:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:53 INFO - Running setup.py (path:/tmp/pip-KOoQHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:53 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:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:53 INFO - Running setup.py (path:/tmp/pip-G2JEsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:53 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:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:53 INFO - Running setup.py (path:/tmp/pip-cMwbg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:54 INFO - Running setup.py (path:/tmp/pip-H_ig4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:54 INFO - Running setup.py (path:/tmp/pip-1Fl4Zs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:54 INFO - Running setup.py (path:/tmp/pip-K5eA_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:54 INFO - Running setup.py (path:/tmp/pip-DbtG4y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:54 INFO - Running setup.py (path:/tmp/pip-uYEU3c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:54 INFO - Running setup.py (path:/tmp/pip-q8WQkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:54 INFO - Running setup.py (path:/tmp/pip-IIq7kv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:54 INFO - Running setup.py (path:/tmp/pip-4uxiZA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:54 INFO - Running setup.py (path:/tmp/pip-snUa3i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:54 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:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:54 INFO - Running setup.py (path:/tmp/pip-JUU5DR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:54 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:59:54 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:59:54 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:59:54 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:59:54 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:59:54 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:59:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:59: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:59: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:59: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:59: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:59: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:59: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:59:56 INFO - Downloading blessings-1.5.1.tar.gz 22:59:56 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:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:59:56 INFO - Installing collected packages: blessings 22:59:56 INFO - Running setup.py install for blessings 22:59:56 INFO - Successfully installed blessings 22:59:56 INFO - Cleaning up... 22:59:56 INFO - Return code: 0 22:59:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:59:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:59:56 INFO - Reading from file tmpfile_stdout 22:59:56 INFO - Current package versions: 22:59:56 INFO - argparse == 1.2.1 22:59:56 INFO - blessings == 1.5.1 22:59:56 INFO - blobuploader == 1.2.4 22:59:56 INFO - docopt == 0.6.1 22:59:56 INFO - manifestparser == 1.1 22:59:56 INFO - mozInstall == 1.12 22:59:56 INFO - mozcrash == 0.16 22:59:56 INFO - mozdebug == 0.1 22:59:56 INFO - mozdevice == 0.47 22:59:56 INFO - mozfile == 1.2 22:59:56 INFO - mozhttpd == 0.7 22:59:56 INFO - mozinfo == 0.9 22:59:56 INFO - mozleak == 0.1 22:59:56 INFO - mozlog == 3.1 22:59:56 INFO - moznetwork == 0.27 22:59:56 INFO - mozprocess == 0.22 22:59:56 INFO - mozprofile == 0.28 22:59:56 INFO - mozrunner == 6.11 22:59:56 INFO - mozscreenshot == 0.1 22:59:56 INFO - mozsystemmonitor == 0.0 22:59:56 INFO - moztest == 0.7 22:59:56 INFO - mozversion == 1.4 22:59:56 INFO - psutil == 3.1.1 22:59:56 INFO - requests == 1.2.3 22:59:56 INFO - wsgiref == 0.1.2 22:59:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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:59:56 INFO - Using env: {'DISPLAY': ':0', 22:59:56 INFO - 'HOME': '/home/cltbld', 22:59:56 INFO - 'LANG': 'en_US.UTF-8', 22:59:56 INFO - 'LANGUAGE': 'en_US:en', 22:59:56 INFO - 'LOGNAME': 'cltbld', 22:59:56 INFO - 'MAIL': '/var/mail/cltbld', 22:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:56 INFO - 'MOZ_NO_REMOTE': '1', 22:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:56 INFO - 'NO_EM_RESTART': '1', 22:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:56 INFO - 'SHELL': '/bin/bash', 22:59:56 INFO - 'SHLVL': '1', 22:59:56 INFO - 'TERM': 'linux', 22:59:56 INFO - 'TMOUT': '86400', 22:59:56 INFO - 'USER': 'cltbld', 22:59:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:56 INFO - '_': '/tools/buildbot/bin/python'} 22:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:57 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:59:57 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:59:57 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:59:57 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:59:57 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:59:57 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:59:57 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:59:57 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:59:57 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:59:57 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:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:59:57 INFO - Cleaning up... 22:59:57 INFO - Return code: 0 22:59:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:59:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:59:57 INFO - Using env: {'DISPLAY': ':0', 22:59:57 INFO - 'HOME': '/home/cltbld', 22:59:57 INFO - 'LANG': 'en_US.UTF-8', 22:59:57 INFO - 'LANGUAGE': 'en_US:en', 22:59:57 INFO - 'LOGNAME': 'cltbld', 22:59:57 INFO - 'MAIL': '/var/mail/cltbld', 22:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:57 INFO - 'MOZ_NO_REMOTE': '1', 22:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:57 INFO - 'NO_EM_RESTART': '1', 22:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:57 INFO - 'SHELL': '/bin/bash', 22:59:57 INFO - 'SHLVL': '1', 22:59:57 INFO - 'TERM': 'linux', 22:59:57 INFO - 'TMOUT': '86400', 22:59:57 INFO - 'USER': 'cltbld', 22:59:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:57 INFO - '_': '/tools/buildbot/bin/python'} 22:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:57 INFO - Downloading/unpacking jsonschema 22:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:59 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:59:59 INFO - Downloading/unpacking functools32 (from jsonschema) 22:59: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:59: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:59: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:59: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:59: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:59: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:59:59 INFO - Downloading functools32-3.2.3-2.tar.gz 22:59:59 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:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:59:59 INFO - warning: no files found matching '*.txt' 22:59:59 INFO - no previously-included directories found matching 'build' 22:59:59 INFO - no previously-included directories found matching 'dist' 22:59:59 INFO - no previously-included directories found matching '.git*' 22:59:59 INFO - Installing collected packages: jsonschema, functools32 22:59:59 INFO - Running setup.py install for functools32 22:59:59 INFO - warning: no files found matching '*.txt' 22:59:59 INFO - no previously-included directories found matching 'build' 22:59:59 INFO - no previously-included directories found matching 'dist' 22:59:59 INFO - no previously-included directories found matching '.git*' 22:59:59 INFO - Successfully installed jsonschema functools32 22:59:59 INFO - Cleaning up... 22:59:59 INFO - Return code: 0 22:59:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea3e12ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', '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:59:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:59:59 INFO - Using env: {'DISPLAY': ':0', 22:59:59 INFO - 'HOME': '/home/cltbld', 22:59:59 INFO - 'LANG': 'en_US.UTF-8', 22:59:59 INFO - 'LANGUAGE': 'en_US:en', 22:59:59 INFO - 'LOGNAME': 'cltbld', 22:59:59 INFO - 'MAIL': '/var/mail/cltbld', 22:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:59 INFO - 'MOZ_NO_REMOTE': '1', 22:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:59 INFO - 'NO_EM_RESTART': '1', 22:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:59 INFO - 'SHELL': '/bin/bash', 22:59:59 INFO - 'SHLVL': '1', 22:59:59 INFO - 'TERM': 'linux', 22:59:59 INFO - 'TMOUT': '86400', 22:59:59 INFO - 'USER': 'cltbld', 22:59:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 22:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:59 INFO - '_': '/tools/buildbot/bin/python'} 22:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:59 INFO - Downloading/unpacking flake8 22:59: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:59: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:59: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:59: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:59: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:59: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 23:00:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:00:01 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 23:00:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:00:01 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 23:00:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:01 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 23:00:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:00:02 INFO - no previously-included directories found matching 'docs/_build' 23:00:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:00:02 INFO - Running setup.py install for pep8 23:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:00:02 INFO - no previously-included directories found matching 'docs/_build' 23:00:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:00:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:00:02 INFO - Cleaning up... 23:00:02 INFO - Return code: 0 23:00:02 INFO - Running post-action listener: _resource_record_post_action 23:00:02 INFO - Running post-action listener: _start_resource_monitoring 23:00:02 INFO - Starting resource monitoring. 23:00:02 INFO - ##### 23:00:02 INFO - ##### Running install step. 23:00:02 INFO - ##### 23:00:02 INFO - Running pre-action listener: _resource_record_pre_action 23:00:02 INFO - Running main action method: install 23:00:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:00:02 INFO - Reading from file tmpfile_stdout 23:00:02 INFO - Detecting whether we're running mozinstall >=1.0... 23:00:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:00:02 INFO - Reading from file tmpfile_stdout 23:00:02 INFO - Output received: 23:00:02 INFO - Usage: mozinstall [options] installer 23:00:02 INFO - Options: 23:00:02 INFO - -h, --help show this help message and exit 23:00:02 INFO - -d DEST, --destination=DEST 23:00:02 INFO - Directory to install application into. [default: 23:00:02 INFO - "/builds/slave/test-pgo"] 23:00:02 INFO - --app=APP Application being installed. [default: firefox] 23:00:02 INFO - mkdir: /builds/slave/test-pgo/build/application 23:00:02 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'] 23:00:02 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 23:00:18 INFO - Reading from file tmpfile_stdout 23:00:18 INFO - Output received: 23:00:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:00:18 INFO - Running post-action listener: _resource_record_post_action 23:00:18 INFO - ##### 23:00:18 INFO - ##### Running run-tests step. 23:00:18 INFO - ##### 23:00:18 INFO - Running pre-action listener: _resource_record_pre_action 23:00:18 INFO - Running main action method: run_tests 23:00:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:00:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:00:18 INFO - Python 2.7.3 23:00:18 INFO - Return code: 0 23:00:18 INFO - grabbing minidump binary from tooltool 23:00:18 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')]} 23:00:18 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 0x2258660>, '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 0x2259560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:00:18 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 23:00:18 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 23:00:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:00:18 INFO - Return code: 0 23:00:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:00:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:00:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:00:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:00:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:00:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:00:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:00:19 INFO - Return code: 0 23:00:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 23:00:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 23:00:19 INFO - Using env: {'DISPLAY': ':0', 23:00:19 INFO - 'HOME': '/home/cltbld', 23:00:19 INFO - 'LANG': 'en_US.UTF-8', 23:00:19 INFO - 'LANGUAGE': 'en_US:en', 23:00:19 INFO - 'LOGNAME': 'cltbld', 23:00:19 INFO - 'MAIL': '/var/mail/cltbld', 23:00:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:00:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:19 INFO - 'MOZ_NO_REMOTE': '1', 23:00:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:19 INFO - 'NO_EM_RESTART': '1', 23:00:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:19 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:00:19 INFO - 'SHELL': '/bin/bash', 23:00:19 INFO - 'SHLVL': '1', 23:00:19 INFO - 'TERM': 'linux', 23:00:19 INFO - 'TMOUT': '86400', 23:00:19 INFO - 'USER': 'cltbld', 23:00:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293', 23:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:19 INFO - '_': '/tools/buildbot/bin/python'} 23:00:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:00:19 INFO - mozversion application_buildid: 20160105203052 23:00:19 INFO - mozversion application_changeset: 1a9729efc3da75a85714f20c1afd471b9e684dfb 23:00:19 INFO - mozversion application_display_name: Nightly 23:00:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:00:19 INFO - mozversion application_name: Firefox 23:00:19 INFO - mozversion application_remotingname: firefox 23:00:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:00:19 INFO - mozversion application_vendor: Mozilla 23:00:19 INFO - mozversion application_version: 46.0a1 23:00:19 INFO - mozversion platform_buildid: 20160105203052 23:00:19 INFO - mozversion platform_changeset: 1a9729efc3da75a85714f20c1afd471b9e684dfb 23:00:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:00:19 INFO - mozversion platform_version: 46.0a1 23:00:19 INFO - using testdate: 1452063619 23:00:19 INFO - actual date: 1452063619 23:00:19 INFO - starting webserver on 'localhost:33273' 23:00:19 INFO - SUITE-START | Running 3 tests 23:00:19 INFO - TEST-START | dromaeo_css 23:00:19 INFO - operating with platform_type : linux_ 23:00:19 INFO - Initialising browser for dromaeo_css test... 23:00:19 INFO - TEST-INFO | started process 17153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1BEIY3/profile http://localhost:33273/getInfo.html) 23:00:23 INFO - PROCESS | 17153 | __metrics Screen width/height:1600/1200 23:00:23 INFO - PROCESS | 17153 | colorDepth:24 23:00:23 INFO - PROCESS | 17153 | Browser inner width/height: 1024/697 23:00:23 INFO - PROCESS | 17153 | __metrics 23:00:23 INFO - PROCESS | 17153 | 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:00:23 INFO - PROCESS | 17153 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:00:24 INFO - TEST-INFO | 17153: exit 0 23:00:24 INFO - Browser initialized. 23:00:24 INFO - Running cycle 1/1 for dromaeo_css test... 23:00:24 INFO - TEST-INFO | started process 17248 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1BEIY3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:36 INFO - PROCESS | 17248 | RSS: Main: 150130688 23:00:36 INFO - PROCESS | 17248 | 23:01:27 INFO - PROCESS | 17248 | 1452063687257 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] 23:03:36 INFO - PROCESS | 17248 | Cycle 1(1): loaded http://localhost:33273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33273/tests/dromaeo/cssquery-ext.html) 23:03:37 INFO - PROCESS | 17248 | RSS: Main: 249266176 23:03:37 INFO - PROCESS | 17248 | 23:06:40 INFO - PROCESS | 17248 | Cycle 1(1): loaded http://localhost:33273/tests/dromaeo/cssquery-ext.html (next: http://localhost:33273/tests/dromaeo/cssquery-jquery.html) 23:06:40 INFO - PROCESS | 17248 | RSS: Main: 235962368 23:06:40 INFO - PROCESS | 17248 | 23:09:42 INFO - PROCESS | 17248 | Cycle 1(1): loaded http://localhost:33273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33273/tests/dromaeo/cssquery-mootools.html) 23:09:43 INFO - PROCESS | 17248 | RSS: Main: 224096256 23:09:43 INFO - PROCESS | 17248 | 23:12:45 INFO - PROCESS | 17248 | Cycle 1(1): loaded http://localhost:33273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33273/tests/dromaeo/cssquery-prototype.html) 23:12:45 INFO - PROCESS | 17248 | RSS: Main: 212299776 23:12:45 INFO - PROCESS | 17248 | 23:15:48 INFO - PROCESS | 17248 | Cycle 1(1): loaded http://localhost:33273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33273/tests/dromaeo/cssquery-yui.html) 23:15:48 INFO - PROCESS | 17248 | RSS: Main: 213635072 23:15:48 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | Cycle 1(1): loaded http://localhost:33273/tests/dromaeo/cssquery-yui.html (next: http://localhost:33273/tests/dromaeo/cssquery-dojo.html) 23:18:51 INFO - PROCESS | 17248 | RSS: Main: 278478848 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | __start_tp_report 23:18:51 INFO - PROCESS | 17248 | _x_x_mozilla_page_load 23:18:51 INFO - PROCESS | 17248 | _x_x_mozilla_page_load_details 23:18:51 INFO - PROCESS | 17248 | |i|pagename|runs| 23:18:51 INFO - PROCESS | 17248 | |0;dojo.html;3161.9723589833307;3182.6339970903355;3224.854881530331;3228.2252259457737;3255.9674403255967;4993.6254780891395;5121.769520371583;5171.0950583647855;5186.611004174688;5219.399769026563;5227.085260079481;5260.184671375943;5289.629725919187;5301.628885977983;5354.14333706607;4786.808527658898;4801.73590452525;4813.518648135176;4875.902481950359;4879.975600121995;4637.86086417408;4859.149648811462;4907.2148456247005;4924.655274130812;4970.552650261476;4722.268048452495;4785.090832741786;4830.178869592178;4863.367762190928;4877.170880950247;4760.619150467989;4762.809487620491;4764.547368000034;4770.904581908377;4799.424069111729;4622.768861556909;4724.95275047252;4755.310479980383;4778.331033655291;4800.207965685658;4979.278004689299;4987.775550100254;4992.2511623256805;5005.874853128665;5018.64869459138;5469.343678758574;5470.972645136749;5538.446155384469;5556.527695145917;5566.443355664442;5712.200291959129;5726.055200891889;5728.713564321809;5733.569982251348;5734.025215713297;5109.642325037212;5330.1205301125265;5338.866528336784;5341.038613049611;5346.144616861284;5490.203920431515;5527.032769265363;5717.628354156966;5826.242588463558;5852.795152169739;5521.199426083195;5550.72246387679;5554.861128471821;5596.636218645775;5603.719814009283;5613.382527921925;5657.43425657431;5671.9716401418555;5676.148577713376;5676.574256930664;5474.452554744574;5575.581831362664;5581.804636837691;5602.187682785973;5711.143328500758;5680.68756218412;5689;5698.6580805151825;5716.314042314865;5736.885262294731;4417.933730994037;4426.800793964279;4427.5572442755465;4430.800613972379;4466.59800617946;3809.2191100824266;3874.089588946595;3889.4943657324366;3957;3969.166475040216;5272.736363181825;5280.9207861882105;5283.815066472655;5307.442718514578;5327.653702509325;5580.19087232349;5622.212890195376;5623.493885550321;5633.887322253532;5658.688772117491;5063.240513922941;5108.106081435734;5153.252778347119;5271.578273738091;5327.067763141435;4818.156822556039;4876.975615121902;4879.316895634614;4882.194437917775;4925.261210818406;5738.397468265855;5790.536757059425;5796.3913789052385;5807.593468457252;5842.649441033552;5500.834974950758;5594.272744543347;5601.551875850004;5604.747786349705;5619.831405057855;5834.795782147774;5876.6180198286975;5921.348651648402;5927.881442371215;5962.791302304398;5612.242347283064;5614.21401003868;5618.438156184349;5635.154726791015;5644.463775941279;5515.669059856422;5557.499825015768;5613.242212301287;5758.1362795581;5764.682942438206;5543.584231182596;5613.747381367766;5616.747246374005;5622.072358060874;5655.547556195576;5477.4796394342475;5550.195221692913;5551.8889622208135;5557.499825015768;5561.6663000220115;5194.766235519335;5290.44450332725;5298.8940221196135;5447.428020057837;5512.228288039598;5499.065158922913;5563.221149039218;5570.136628822539;5617.606767526398;5617.943820561742;5432.130859062531;5455.781768729206;5464.836054918359;5466.316710411199;5477 23:18:51 INFO - PROCESS | 17248 | |1;ext.html;520.4327283261247;533.7891532844526;534.3107391465011;538.2518299563604;558.4499268220802;28084.297892552695;28942.421151576957;28957.56563651547;28979.130626081223;35881.46177807335;39351;39792.60207397925;39877.202455950865;39891.20217595647;39916.20167596646;8513.829723405528;8679.609417576225;8681.913180868174;8682.392232543725;8691.60887760049;7525.134609519921;7726.111497177812;10089.495525223747;10358.689239322795;10374.688759337232;10044.949775251114;10139.34094283873;10140.340877842953;10155.492225388738;10167.796644067113;7476.289752473506;7675.654595543214;10029.197664186848;10105.04002119801;10132.341397809156;10046.246531510165;10369;10374.118199952938;10374.325668831501;10386.169106471463;37080.44379334312;37409.25181496355;37489.06277343088;37502.4997000359;37557;3146.7639927005566;3176.28533579945;3320.286138480214;3514.38498262803;3590.874319398835;28490.145295640956;28862;28912;29363.706362936526;30745.692543074507;4001.919961600752;4003;4075.857344992911;4081.571434999312;4204.558521355275;221517;223362;223502;223575.99999999837;223802;51619.48380516222;53246.73376633092;56021.43978560244;56413.71793141008;61478;55803.441965580634;56141.71929140328;56148;56244;56248.43751562514;14149.575512734635;14293.57119286423;14305;14326.856731432761;14348.784768228485;10487.94756026215;10495.107915827088;10542.156627469783;10545.050945414949;10557.049865512141;19708.901455492633;20661.483462913246;20684.793152068287;20691.585888328256;20732.58534829295;7625;7742.6902923883545;7763.107242667053;7940.801479963047;7979.162187970295;872.9650813967497;884.5002573545926;893.3344658229661;914.492456686532;935.8034812689411;26057.60913586298;26085.869570652027;26307.342316442242;26361.209163725118;26467.735322646913;943.2926403210212;979.7697541077841;1011.1152741351318;1091.165258577189;1109.5728144664201;14200.786988195185;14514;14538.927305363406;14701.926490367694;14743.926280368743;383333;390401;391531;392108;392523;54548.72725636346;55478.445215548134;55500.44499554953;55552.16671749927;55584.444155557925;1269.2321145706899;1309.7773378525674;1321.6563693439582;1323.3052647360214;1329.8071779591905;26382.340441489116;27150;27837.582436263878;27864.442711146068;27992.58011129794;44689;45395.09209815719;45485.5885808559;45507;45576.31635525536;301674;301893;303181;304375;305657;27646;28315;31420;32352.83823580867;32716.055555000163;36672.449913251854;37160.256794864494;37206;37491.43762843505;37697.2460550793;32513.512297316032;32595.674043259263;32739.508907366886;32957.835210823796;33017;29749.851250743606;31938.20154496156;32646.34707305888;34395.484067739504;37085.62914370822;31830.204244894063;32438.189045274055;32671.836640816644;32676.83661581677;32727;27728.861355693094;28570.285742856595;30348.089557313317;31386.21534461657;31855.203619909687;23394.532109358057;24040.87979560091;24190.395240119138;24438.755612444358;24452.51094978126 23:18:51 INFO - PROCESS | 17248 | |2;jquery.html;356.819805997971;360.4971065363816;363.086836605936;364.5734490645944;366.51070820454686;14048.297585120754;14217.084670549553;16081.597960050989;16440.83559164408;17015.14924253787;15688.686226275468;15992.76010859838;16336.428225012127;16461.91769041153;16495.752563711525;5220.738963051851;5366.892662146754;5367.087595108841;5369.355677318707;5369.973150134244;4022;4162.209180255742;5359.9732001339935;5412.648177868446;5657.264555607786;5756.424357564252;5791.536677065846;5791.681457519835;5793.536517078624;5803.21656576361;5656.971715141419;5768.307803063659;5775.971120144372;5805.100209467518;5815.941840581582;5107.616928730323;5124.769385377667;5141.76862041209;5142.665726727788;5143.305653736773;20452.386428407022;20948.5810283795;20952.790472095236;21038.894805525873;21383.358499244892;2082.9270975515783;2085.0200405809246;2119.7456305243313;2203.7575866654656;2362.3739708977137;12971.935140324333;13196.538121165713;13290.202587844664;13450.858969236955;13476.93261533686;1754.5789010637482;1767.2930827668906;1797.4787311679597;1878.5585387433941;1914.2438736698925;54977.72511137459;58463.70768146175;58584;58591.414085859025;59358.703206484555;9849.901500985041;9853.950730246303;10099.242556808269;10099.848502272473;10159.136473399696;13204.933975330061;13215.141015834133;13217.140885842582;13221.867781322064;13242.404091815892;7445.069366329209;7445.739399121005;7455.7017719290625;7515.286047825557;7567.9243207567215;7175.17485489165;7184.245654206337;7234;7236.167840698282;7243.927560724431;5964.135200396005;6006.459418652343;6030.638161710312;6031.487323577545;6067.969660151671;1655.6771429571118;1709.7862767154106;1710.2987775012186;1719.6388758360883;1756.244814729653;898.5552151684827;911.4850109688005;983.0759086458706;1047.7328281288223;1054.1408751867205;16118.838811611733;16244;16807.41174058902;17331.913340433217;17601.91199044022;871.3639043498282;871.9869201961976;872.9519876406858;897.6005677473462;928.0811996123924;9211.447313161232;9677;10181.134603558632;10187.949060254652;10243.84634230487;385540;391387;392430;392756;393275;74952;76590.23409765943;76830.61584692041;76946.61526692443;77695;1139.8746137924823;1157.5080590748898;1158.2818652435544;1160.158884808524;1160.7504386556932;15814.841851581337;15839.128847913475;15868.2065896707;15881.444149454714;16057.518274451784;34042.489362659086;34174.487382688785;34219;35081.298374032885;35836.10409739673;44930.55069449394;45677.54322456733;45683;45956.7702161487;46412.30381544347;9613.423194608346;9717.076877696607;9822.901770982198;9859.802803943738;9870.506474676382;14076.648083797987;16329.591760206089;17325.220365083853;17627.294908203527;17668.381606643707;12156.75686486283;12323.075769317516;13195.538156164488;14397.568072957829;14541.12753234767;13993.580192594238;14700.779488307899;14784.260786960824;14885.330160143036;15305.540833775005;12124.333161676192;14663.633409164857;15390.230488475756;15412.614684632974;15849.603759905633;9311.255099591881;9580.18568421692;9744.853827192455;9747.707568772948;9822.165115965223;10459.529321180717;12572.685682858002;14070.155790652185;14196.503122390666;14600.152970170715 23:18:51 INFO - PROCESS | 17248 | |3;mootools.html;1287.6909541709992;1412.3009110490307;1423.5088894331454;1560.6176486760746;1770.0795586295135;6555.573887697296;7246.166690830556;7335.266473352662;7342.522736022155;7344.706211751523;7036.964815175917;7223.566586004843;7225.169105552863;7233.348998590126;7237.529560578572;1931.6812725900209;1944.9805501945011;1963.7643482782087;1974.6149500847268;2185.3771675072608;2259.53679495703;2267.4444761033487;2269.7616750241236;2270.2621647964397;2271.5116250006245;2113.651247544153;2176.9455763605956;2192.3642143778284;2197.505561248722;2198.626233540294;1907.6661584222775;1945.0566475259488;2017.1225516900122;2058.87646741196;2064.370367038053;2155.6874253233195;2160.5786871560053;2176;2182.2034957240653;2183.290430610058;7262.709491620329;7361.6319184040585;7362.484626076177;7368.705251789922;7371.115466144043;4467.463904331468;4516.390287311204;4538.069695712371;4544.568266014723;4546.272596384596;2801.649793775778;2893.6382952130984;2908.389238259968;2916.460454815866;2921.839298838563;947.2280091725222;954.5418199264392;960.188640598693;985.393982700634;997.4015590645627;10288.79422411555;10291.794164116676;10303.639372621998;10307.94846025765;10315.123214526699;3931.5871833457077;4003.819828107742;4142.565030671796;4158.126793373425;4199.832006719758;8982.775430614287;8997.055309192441;9001.234895033864;9007.324450666096;9013.729588112366;4427.380166776654;4430.357598148251;4442.067165895133;4444.666650001198;4457.598816106566;4109.0959988802415;4113.85601503946;4117.526484454266;4121.9587804122175;4124.9587504125175;3508.0241467838923;3532.4171511700797;3532.434810430319;3576.338377400189;3580.606133325332;1108.6895669212633;1109.1514991031868;1117.4245263689206;1122.938238396896;1124.4602590756483;919.4575200631659;934.4299977014016;941.712777602824;948.9430634161972;1064.6114168328659;6356.841078973062;6952.130983627047;7108.431325493948;7110.146782386147;7128.821779455555;597.1132867691562;608.796053322142;610.9663968481688;611.0376157551785;623.3735096228262;5614.073677843192;5675.57433192504;5682;5705.857353566194;5717.371089180187;8726;8981.730548083568;9020.097990200928;9036.23192028685;9125.45247285165;9009.459432434074;9130.406523575946;9141.405808622418;9162.22121119699;9177.449353038839;6918.723251070001;7172.390346820579;7176.892346614805;7205.92794072063;7245.094363204494;6892.517523773488;6937.930620693728;6965.79102626922;6968.860622787617;6969.965150174216;7989.480683755537;8123.75628731139;8140.348772098337;8145.470544414594;8272.503649781032;8215.219554142346;8217.096119426978;8333.833323333378;8336.87494687568;8344.040435349769;6525.8694826104165;6681.899771503528;6685.130932978682;6689.899651505329;6697;6906.585604863523;6924.515283930076;6931.1682598088555;6940.27127151662;6948.444124469929;6658.83352916181;6758.256591774999;6758.763443279461;6885.586864788129;6889.448844092561;6501.284858665448;6588.40704336612;6663.133792607124;6792.66036698173;6854.246032936273;6802.251752307143;6837.247902730795;6876.724931002704;6881.208661004049;6895.793126206222;6395.296517383177;6412.422881940648;6431.646259455588;6436.645984470899;6443.581167224303;6233.2208473940755;6241.032639940817;6289.528285378524;6292.2134733158355;6312.6528040956355 23:18:51 INFO - PROCESS | 17248 | |4;prototype.html;318.38074944233466;319.62444128149417;321.3027729826277;331.9385913605983;333.20530534674793;5951.13708512266;5971.880562388749;5980.730867110985;6001.909971350422;6004;5688.744006519706;5744.109663002241;5800.854978625536;5883.352831188566;5907.143464197688;4540.795664195102;4546.613537849286;4553.977230113845;4560.8859778505475;4561.56665116815;4381.277089280265;4556.476005259405;4567.08658268346;4572.474165470981;4572.679912406133;4434.201843668138;4434.512203657595;4519.367288579601;4519.548045195487;4532.09358128374;4493.662975276868;4493.865184044451;4511.729296242236;4514.458265008204;4530.70550414222;4019.2363450944226;4026.2148880968225;4026.959730402688;4027.154297597479;4038.676905847525;5554.585501404358;5676.290463692038;5678.801241956553;5680.0627896397045;5693.231413759131;5325.387580428262;5329.360476742816;5338.599605029638;5340.62615616907;5342.626016178869;6280.717367718418;6304.716287767062;6306.274778400497;6307.590006649553;6314.368563143695;4462.509123996358;4465.6650751193465;4466.062126953344;4466.1067786442845;4471.23988921884;6400.327965563595;6501.057346684752;6554.377334153248;6591.4397276231575;6596.175478065194;4592.10453961481;4594.5864872161665;4595.6783025187915;4596.172688916027;4600.21796294624;4651.4418269807165;4656.115338085753;4660.743659098782;4662.160811053975;4663.253879379283;5310.176922577007;5324.281222034976;5333.866653333697;5337.599680024014;5337.772312368177;6153.261608606996;6334.588251763621;6338.936610633835;6344.49244060474;6361.777337793155;1600.7038697840937;1610.0500704584351;1610.2351383092937;1612.4114698135331;1612.475945317753;1098.4397957041806;1107.197281970565;1109.606089838112;1117.5976648406568;1130.9547618095185;6008.24896887889;6013.30846952606;6015.097735339734;6020.247469066367;6028.969855150696;6499.837504062341;6511.544191906616;6514.3811337922825;6515.120458738104;6521.184851893513;5784.1008459505765;5815.563832712563;5953.672548009901;6028.577999540078;6057.333693293822;3450.1547120955524;3497.213127046394;3500.807455589916;3501.77238479498;3503.579570451562;6709.899351509731;6814.727410903607;6818.761343352959;6825.658717064226;6831.146106736658;6758.831029224309;6764.729410823512;6768.76309329181;6773.153355830521;6778.084958530634;6617.371349721769;6661.4337781287195;6777.762778302835;6805.6597170141295;6814.557053791487;6537.248216455168;6541.383446621389;6545.934540654533;6547.770828020996;6549.574277671936;6457.935420645921;6482.092507048923;6484.481241500763;6485.513586480938;6490;6614.536982411378;6780.627065511444;6787.287334829772;6791.286914874065;6795;4591.540845915515;4595.058013107372;4598.241290187082;4600.907981840412;4603.608693261111;6567.474602031922;6568.770093046721;6573.57271777333;6573.934260657332;6582.637954912526;6222.28443728977;6389.9361006389345;6421.133147025279;6434.388733070351;6436.774712885027;6388.616682999035;6406.0390941359165;6414.486841052798;6419.197600299963;6421.325760795049;6298.9921612541775;6299.779507717208;6301.212348456443;6305.274893387319;6305.873882522415;6244.063390491463;6453.548251622529;6461.64460954652;6462.579932304385;6465.612063276219;6044.455998960115;6148.631082135086;6190.566660333733;6281.560290779602;6298.535805306971 23:18:51 INFO - PROCESS | 17248 | |5;yui.html;730.4485113739127;732.3408931961234;790.9446338756286;808.5997431271521;830.0827585518002;13031.022673299505;13295.933520332408;13364.532241371555;13473.124246923955;13506.257155856423;14911;15276.618084547892;15296.31166597503;15302.540923772276;15311.310991005405;683.7880257120308;694.1982010777534;700.3906601256888;834.5368320582074;842.2756429470651;829.2495291760966;846.4540371460404;851.8637018077109;852.40757673417;852.722865068852;883.5361435246483;883.6774577279278;887.4941283468426;887.8313120507083;888.9199972002518;723.027527974873;731.893875388071;873.1966590736538;875.4309698695866;891.5809569502388;651.1730102769457;651.2347991110427;651.5406638319973;651.7718798420563;652.3215855510264;13805.378757955816;13913.930430347884;13935.954803389684;13948.860511394858;13956.72086558263;12606.621801345975;12998.740025199442;13051.86948130516;13092.214467132002;13524.797128043087;9948.154406875425;10444.79110417795;10488.265821392506;10625.787484250272;10718.464076796128;3613.5483064616924;3697.6856967157823;3705.055210921225;3714.201446688975;3783.8108094595436;47206.5279347209;47262.054758904975;47697.52302477;49124.754376228244;49131.75434122842;10363.585456581652;10615.575376984834;10639.946800265949;10679.412632305142;10760.139188864872;19048.71426928597;19052.428427147206;19161.616767664567;19207.231710731416;19224.231030758612;7611.619419029026;7826.686932522749;7902;7919.089304729914;7928.5242885425905;4415.205263052617;4553.567411095941;4589.4722106958125;4635.768211589474;4701.106789709944;3082.090783218956;3116.844157792101;3122.718955293989;3123.54708567261;3125.718685318332;535.5073332534;549.4313385645837;555.2199160179954;558.1794761700294;565.2115299157653;627.8304857688398;648.2933602373436;658.6937074260492;683.8427161752825;691.6368906324119;8574.614142363609;8666.826663466696;8795.956020219857;8812.8678069829;8892.377533572717;611.4924612571555;618.4032408725601;654.1153513007614;659.6306068601599;666.8399584099781;4151.12826306473;4218.49378074633;4255.361695745601;4276.444062271947;4414.139242847678;53552.19671704849;53830;54123.72938135284;54204;55075.72462137744;49634.50365496371;50055.49944500509;50065.49934500609;50131.74934125306;50308.496915031115;43218;44389.77805110954;44452.777736111115;44743.32885006727;45726.77136614296;8270.710525131592;8271.22168733725;8356.456830306011;8402.865613142147;8506.362022848434;34931.650683493855;35507.82246088753;35609.82195089111;35757.82121089378;36136.63863361333;41236;44235.55764442443;44337;44604;47758.07612346024;10954.287971281841;11027.724306892393;11137.888621113685;11304;11448.427578621202;12231.327276999851;12519.499220031097;12642.747145056863;13072.215667060007;13088.738225235633;11079.833802492807;11364.147688923198;11527.942360288145;11754.23597466162;11774.82337764917;11290.266132701348;11384.943075284571;11439.828402573801;11726.589569365031;11922.403879806148;10757.1932105094;11010.50452729613;11102.333859968428;11444.427778611203;11551.653450396501;9594.280428967715;9847.63049774702;9941.403515789076;10147.695569132939;10497.370157790558;8754.242313998484;9005.459672419676;9611.327207095435;9883.851742224017;10131.392116473035 23:18:51 INFO - PROCESS | 17248 | __end_tp_report 23:18:51 INFO - PROCESS | 17248 | __start_cc_report 23:18:51 INFO - PROCESS | 17248 | _x_x_mozilla_cycle_collect,749 23:18:51 INFO - PROCESS | 17248 | __end_cc_report 23:18:51 INFO - PROCESS | 17248 | __startTimestamp1452064731759__endTimestamp 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | ------- Summary: start ------- 23:18:51 INFO - PROCESS | 17248 | Number of tests: 6 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | [#0] dojo.html Cycles:165 Average:5235.88 Median:5466.32 stddev:571.57 (10.5%) stddev-sans-first:549.68 23:18:51 INFO - PROCESS | 17248 | Values: 3162.0 3182.6 3224.9 3228.2 3256.0 4993.6 5121.8 5171.1 5186.6 5219.4 5227.1 5260.2 5289.6 5301.6 5354.1 4786.8 4801.7 4813.5 4875.9 4880.0 4637.9 4859.1 4907.2 4924.7 4970.6 4722.3 4785.1 4830.2 4863.4 4877.2 4760.6 4762.8 4764.5 4770.9 4799.4 4622.8 4725.0 4755.3 4778.3 4800.2 4979.3 4987.8 4992.3 5005.9 5018.6 5469.3 5471.0 5538.4 5556.5 5566.4 5712.2 5726.1 5728.7 5733.6 5734.0 5109.6 5330.1 5338.9 5341.0 5346.1 5490.2 5527.0 5717.6 5826.2 5852.8 5521.2 5550.7 5554.9 5596.6 5603.7 5613.4 5657.4 5672.0 5676.1 5676.6 5474.5 5575.6 5581.8 5602.2 5711.1 5680.7 5689.0 5698.7 5716.3 5736.9 4417.9 4426.8 4427.6 4430.8 4466.6 3809.2 3874.1 3889.5 3957.0 3969.2 5272.7 5280.9 5283.8 5307.4 5327.7 5580.2 5622.2 5623.5 5633.9 5658.7 5063.2 5108.1 5153.3 5271.6 5327.1 4818.2 4877.0 4879.3 4882.2 4925.3 5738.4 5790.5 5796.4 5807.6 5842.6 5500.8 5594.3 5601.6 5604.7 5619.8 5834.8 5876.6 5921.3 5927.9 5962.8 5612.2 5614.2 5618.4 5635.2 5644.5 5515.7 5557.5 5613.2 5758.1 5764.7 5543.6 5613.7 5616.7 5622.1 5655.5 5477.5 5550.2 5551.9 5557.5 5561.7 5194.8 5290.4 5298.9 5447.4 5512.2 5499.1 5563.2 5570.1 5617.6 5617.9 5432.1 5455.8 5464.8 5466.3 5477.0 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | [#1] ext.html Cycles:180 Average:46272.14 Median:32145.52 stddev:82380.24 (256.3%) stddev-sans-first:82539.72 23:18:51 INFO - PROCESS | 17248 | Values: 520.4 533.8 534.3 538.3 558.4 28084.3 28942.4 28957.6 28979.1 35881.5 39351.0 39792.6 39877.2 39891.2 39916.2 8513.8 8679.6 8681.9 8682.4 8691.6 7525.1 7726.1 10089.5 10358.7 10374.7 10044.9 10139.3 10140.3 10155.5 10167.8 7476.3 7675.7 10029.2 10105.0 10132.3 10046.2 10369.0 10374.1 10374.3 10386.2 37080.4 37409.3 37489.1 37502.5 37557.0 3146.8 3176.3 3320.3 3514.4 3590.9 28490.1 28862.0 28912.0 29363.7 30745.7 4001.9 4003.0 4075.9 4081.6 4204.6 221517.0 223362.0 223502.0 223576.0 223802.0 51619.5 53246.7 56021.4 56413.7 61478.0 55803.4 56141.7 56148.0 56244.0 56248.4 14149.6 14293.6 14305.0 14326.9 14348.8 10487.9 10495.1 10542.2 10545.1 10557.0 19708.9 20661.5 20684.8 20691.6 20732.6 7625.0 7742.7 7763.1 7940.8 7979.2 873.0 884.5 893.3 914.5 935.8 26057.6 26085.9 26307.3 26361.2 26467.7 943.3 979.8 1011.1 1091.2 1109.6 14200.8 14514.0 14538.9 14701.9 14743.9 383333.0 390401.0 391531.0 392108.0 392523.0 54548.7 55478.4 55500.4 55552.2 55584.4 1269.2 1309.8 1321.7 1323.3 1329.8 26382.3 27150.0 27837.6 27864.4 27992.6 44689.0 45395.1 45485.6 45507.0 45576.3 301674.0 301893.0 303181.0 304375.0 305657.0 27646.0 28315.0 31420.0 32352.8 32716.1 36672.4 37160.3 37206.0 37491.4 37697.2 32513.5 32595.7 32739.5 32957.8 33017.0 29749.9 31938.2 32646.3 34395.5 37085.6 31830.2 32438.2 32671.8 32676.8 32727.0 27728.9 28570.3 30348.1 31386.2 31855.2 23394.5 24040.9 24190.4 24438.8 24452.5 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | [#2] jquery.html Cycles:180 Average:24628.20 Median:34650.15 stddev:64130.12 (185.1%) stddev-sans-first:64284.13 23:18:51 INFO - PROCESS | 17248 | Values: 356.8 360.5 363.1 364.6 366.5 14048.3 14217.1 16081.6 16440.8 17015.1 15688.7 15992.8 16336.4 16461.9 16495.8 5220.7 5366.9 5367.1 5369.4 5370.0 4022.0 4162.2 5360.0 5412.6 5657.3 5756.4 5791.5 5791.7 5793.5 5803.2 5657.0 5768.3 5776.0 5805.1 5815.9 5107.6 5124.8 5141.8 5142.7 5143.3 20452.4 20948.6 20952.8 21038.9 21383.4 2082.9 2085.0 2119.7 2203.8 2362.4 12971.9 13196.5 13290.2 13450.9 13476.9 1754.6 1767.3 1797.5 1878.6 1914.2 54977.7 58463.7 58584.0 58591.4 59358.7 9849.9 9854.0 10099.2 10099.8 10159.1 13204.9 13215.1 13217.1 13221.9 13242.4 7445.1 7445.7 7455.7 7515.3 7567.9 7175.2 7184.2 7234.0 7236.2 7243.9 5964.1 6006.5 6030.6 6031.5 6068.0 1655.7 1709.8 1710.3 1719.6 1756.2 898.6 911.5 983.1 1047.7 1054.1 16118.8 16244.0 16807.4 17331.9 17601.9 871.4 872.0 873.0 897.6 928.1 9211.4 9677.0 10181.1 10187.9 10243.8 385540.0 391387.0 392430.0 392756.0 393275.0 74952.0 76590.2 76830.6 76946.6 77695.0 1139.9 1157.5 1158.3 1160.2 1160.8 15814.8 15839.1 15868.2 15881.4 16057.5 34042.5 34174.5 34219.0 35081.3 35836.1 44930.6 45677.5 45683.0 45956.8 46412.3 9613.4 9717.1 9822.9 9859.8 9870.5 14076.6 16329.6 17325.2 17627.3 17668.4 12156.8 12323.1 13195.5 14397.6 14541.1 13993.6 14700.8 14784.3 14885.3 15305.5 12124.3 14663.6 15390.2 15412.6 15849.6 9311.3 9580.2 9744.9 9747.7 9822.2 10459.5 12572.7 14070.2 14196.5 14600.2 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | [#3] mootools.html Cycles:180 Average:5227.97 Median:6440.11 stddev:2759.47 (42.8%) stddev-sans-first:2751.31 23:18:51 INFO - PROCESS | 17248 | Values: 1287.7 1412.3 1423.5 1560.6 1770.1 6555.6 7246.2 7335.3 7342.5 7344.7 7037.0 7223.6 7225.2 7233.3 7237.5 1931.7 1945.0 1963.8 1974.6 2185.4 2259.5 2267.4 2269.8 2270.3 2271.5 2113.7 2176.9 2192.4 2197.5 2198.6 1907.7 1945.1 2017.1 2058.9 2064.4 2155.7 2160.6 2176.0 2182.2 2183.3 7262.7 7361.6 7362.5 7368.7 7371.1 4467.5 4516.4 4538.1 4544.6 4546.3 2801.6 2893.6 2908.4 2916.5 2921.8 947.2 954.5 960.2 985.4 997.4 10288.8 10291.8 10303.6 10307.9 10315.1 3931.6 4003.8 4142.6 4158.1 4199.8 8982.8 8997.1 9001.2 9007.3 9013.7 4427.4 4430.4 4442.1 4444.7 4457.6 4109.1 4113.9 4117.5 4122.0 4125.0 3508.0 3532.4 3532.4 3576.3 3580.6 1108.7 1109.2 1117.4 1122.9 1124.5 919.5 934.4 941.7 948.9 1064.6 6356.8 6952.1 7108.4 7110.1 7128.8 597.1 608.8 611.0 611.0 623.4 5614.1 5675.6 5682.0 5705.9 5717.4 8726.0 8981.7 9020.1 9036.2 9125.5 9009.5 9130.4 9141.4 9162.2 9177.4 6918.7 7172.4 7176.9 7205.9 7245.1 6892.5 6937.9 6965.8 6968.9 6970.0 7989.5 8123.8 8140.3 8145.5 8272.5 8215.2 8217.1 8333.8 8336.9 8344.0 6525.9 6681.9 6685.1 6689.9 6697.0 6906.6 6924.5 6931.2 6940.3 6948.4 6658.8 6758.3 6758.8 6885.6 6889.4 6501.3 6588.4 6663.1 6792.7 6854.2 6802.3 6837.2 6876.7 6881.2 6895.8 6395.3 6412.4 6431.6 6436.6 6443.6 6233.2 6241.0 6289.5 6292.2 6312.7 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | [#4] prototype.html Cycles:180 Average:5306.25 Median:5991.32 stddev:1592.21 (26.6%) stddev-sans-first:1552.04 23:18:51 INFO - PROCESS | 17248 | Values: 318.4 319.6 321.3 331.9 333.2 5951.1 5971.9 5980.7 6001.9 6004.0 5688.7 5744.1 5800.9 5883.4 5907.1 4540.8 4546.6 4554.0 4560.9 4561.6 4381.3 4556.5 4567.1 4572.5 4572.7 4434.2 4434.5 4519.4 4519.5 4532.1 4493.7 4493.9 4511.7 4514.5 4530.7 4019.2 4026.2 4027.0 4027.2 4038.7 5554.6 5676.3 5678.8 5680.1 5693.2 5325.4 5329.4 5338.6 5340.6 5342.6 6280.7 6304.7 6306.3 6307.6 6314.4 4462.5 4465.7 4466.1 4466.1 4471.2 6400.3 6501.1 6554.4 6591.4 6596.2 4592.1 4594.6 4595.7 4596.2 4600.2 4651.4 4656.1 4660.7 4662.2 4663.3 5310.2 5324.3 5333.9 5337.6 5337.8 6153.3 6334.6 6338.9 6344.5 6361.8 1600.7 1610.1 1610.2 1612.4 1612.5 1098.4 1107.2 1109.6 1117.6 1131.0 6008.2 6013.3 6015.1 6020.2 6029.0 6499.8 6511.5 6514.4 6515.1 6521.2 5784.1 5815.6 5953.7 6028.6 6057.3 3450.2 3497.2 3500.8 3501.8 3503.6 6709.9 6814.7 6818.8 6825.7 6831.1 6758.8 6764.7 6768.8 6773.2 6778.1 6617.4 6661.4 6777.8 6805.7 6814.6 6537.2 6541.4 6545.9 6547.8 6549.6 6457.9 6482.1 6484.5 6485.5 6490.0 6614.5 6780.6 6787.3 6791.3 6795.0 4591.5 4595.1 4598.2 4600.9 4603.6 6567.5 6568.8 6573.6 6573.9 6582.6 6222.3 6389.9 6421.1 6434.4 6436.8 6388.6 6406.0 6414.5 6419.2 6421.3 6299.0 6299.8 6301.2 6305.3 6305.9 6244.1 6453.5 6461.6 6462.6 6465.6 6044.5 6148.6 6190.6 6281.6 6298.5 23:18:51 INFO - PROCESS | 17248 | 23:18:51 INFO - PROCESS | 17248 | [#5] yui.html Cycles:180 Average:13814.37 Median:24648.45 stddev:15509.51 (62.9%) stddev-sans-first:15521.89 23:18:51 INFO - PROCESS | 17248 | Values: 730.4 732.3 790.9 808.6 830.1 13031.0 13295.9 13364.5 13473.1 13506.3 14911.0 15276.6 15296.3 15302.5 15311.3 683.8 694.2 700.4 834.5 842.3 829.2 846.5 851.9 852.4 852.7 883.5 883.7 887.5 887.8 888.9 723.0 731.9 873.2 875.4 891.6 651.2 651.2 651.5 651.8 652.3 13805.4 13913.9 13936.0 13948.9 13956.7 12606.6 12998.7 13051.9 13092.2 13524.8 9948.2 10444.8 10488.3 10625.8 10718.5 3613.5 3697.7 3705.1 3714.2 3783.8 47206.5 47262.1 47697.5 49124.8 49131.8 10363.6 10615.6 10639.9 10679.4 10760.1 19048.7 19052.4 19161.6 19207.2 19224.2 7611.6 7826.7 7902.0 7919.1 7928.5 4415.2 4553.6 4589.5 4635.8 4701.1 3082.1 3116.8 3122.7 3123.5 3125.7 535.5 549.4 555.2 558.2 565.2 627.8 648.3 658.7 683.8 691.6 8574.6 8666.8 8796.0 8812.9 8892.4 611.5 618.4 654.1 659.6 666.8 4151.1 4218.5 4255.4 4276.4 4414.1 53552.2 53830.0 54123.7 54204.0 55075.7 49634.5 50055.5 50065.5 50131.7 50308.5 43218.0 44389.8 44452.8 44743.3 45726.8 8270.7 8271.2 8356.5 8402.9 8506.4 34931.7 35507.8 35609.8 35757.8 36136.6 41236.0 44235.6 44337.0 44604.0 47758.1 10954.3 11027.7 11137.9 11304.0 11448.4 12231.3 12519.5 12642.7 13072.2 13088.7 11079.8 11364.1 11527.9 11754.2 11774.8 11290.3 11384.9 11439.8 11726.6 11922.4 10757.2 11010.5 11102.3 11444.4 11551.7 9594.3 9847.6 9941.4 10147.7 10497.4 8754.2 9005.5 9611.3 9883.9 10131.4 23:18:51 INFO - PROCESS | 17248 | -------- Summary: end -------- 23:18:51 INFO - PROCESS | 17248 | 23:18:52 INFO - TEST-INFO | 17248: exit 0 23:18:52 INFO - TEST-OK | dromaeo_css | took 1112684ms 23:18:52 INFO - TEST-START | kraken 23:18:52 INFO - operating with platform_type : linux_ 23:18:52 INFO - Initialising browser for kraken test... 23:18:52 INFO - TEST-INFO | started process 17439 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAfz1Sc/profile http://localhost:33273/getInfo.html) 23:18:56 INFO - PROCESS | 17439 | __metrics Screen width/height:1600/1200 23:18:56 INFO - PROCESS | 17439 | colorDepth:24 23:18:56 INFO - PROCESS | 17439 | Browser inner width/height: 1024/697 23:18:56 INFO - PROCESS | 17439 | __metrics 23:18:56 INFO - PROCESS | 17439 | 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:18:56 INFO - PROCESS | 17439 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:18:57 INFO - TEST-INFO | 17439: exit 0 23:18:57 INFO - Browser initialized. 23:18:57 INFO - Running cycle 1/1 for kraken test... 23:18:57 INFO - TEST-INFO | started process 17521 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAfz1Sc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:19:09 INFO - PROCESS | 17521 | RSS: Main: 149725184 23:19:09 INFO - PROCESS | 17521 | 23:19:11 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33273/tests/kraken/driver.html?testName=audio-beat-detection) 23:19:12 INFO - PROCESS | 17521 | RSS: Main: 185368576 23:19:12 INFO - PROCESS | 17521 | 23:19:14 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33273/tests/kraken/driver.html?testName=audio-dft) 23:19:15 INFO - PROCESS | 17521 | RSS: Main: 177115136 23:19:15 INFO - PROCESS | 17521 | 23:19:18 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33273/tests/kraken/driver.html?testName=audio-fft) 23:19:18 INFO - PROCESS | 17521 | RSS: Main: 159510528 23:19:18 INFO - PROCESS | 17521 | 23:19:20 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33273/tests/kraken/driver.html?testName=audio-oscillator) 23:19:21 INFO - PROCESS | 17521 | RSS: Main: 163561472 23:19:21 INFO - PROCESS | 17521 | 23:19:23 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:19:24 INFO - PROCESS | 17521 | RSS: Main: 163291136 23:19:24 INFO - PROCESS | 17521 | 23:19:27 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33273/tests/kraken/driver.html?testName=imaging-darkroom) 23:19:27 INFO - PROCESS | 17521 | RSS: Main: 163459072 23:19:27 INFO - PROCESS | 17521 | 23:19:30 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33273/tests/kraken/driver.html?testName=imaging-desaturate) 23:19:31 INFO - PROCESS | 17521 | RSS: Main: 164249600 23:19:31 INFO - PROCESS | 17521 | 23:19:34 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33273/tests/kraken/driver.html?testName=json-parse-financial) 23:19:34 INFO - PROCESS | 17521 | RSS: Main: 165486592 23:19:34 INFO - PROCESS | 17521 | 23:19:36 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:19:36 INFO - PROCESS | 17521 | RSS: Main: 176902144 23:19:36 INFO - PROCESS | 17521 | 23:19:38 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:19:39 INFO - PROCESS | 17521 | RSS: Main: 174444544 23:19:39 INFO - PROCESS | 17521 | 23:19:41 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:19:41 INFO - PROCESS | 17521 | RSS: Main: 182534144 23:19:41 INFO - PROCESS | 17521 | 23:19:44 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:19:44 INFO - PROCESS | 17521 | RSS: Main: 192897024 23:19:44 INFO - PROCESS | 17521 | 23:19:47 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:19:48 INFO - PROCESS | 17521 | RSS: Main: 190574592 23:19:48 INFO - PROCESS | 17521 | 23:19:49 INFO - PROCESS | 17521 | Cycle 1(1): loaded http://localhost:33273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33273/tests/kraken/driver.html?testName=ai-astar) 23:19:50 INFO - PROCESS | 17521 | RSS: Main: 250175488 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | __start_tp_report 23:19:50 INFO - PROCESS | 17521 | _x_x_mozilla_page_load 23:19:50 INFO - PROCESS | 17521 | _x_x_mozilla_page_load_details 23:19:50 INFO - PROCESS | 17521 | |i|pagename|runs| 23:19:50 INFO - PROCESS | 17521 | |0;ai-astar;108;111;103;108;111;111;100;112;110;115 23:19:50 INFO - PROCESS | 17521 | |1;audio-beat-detection;154;126;152;163;129;156;155;128;163;124 23:19:50 INFO - PROCESS | 17521 | |2;audio-dft;161;161;161;163;161;162;160;163;162;162 23:19:50 INFO - PROCESS | 17521 | |3;audio-fft;72;76;81;93;73;70;73;126;93;71 23:19:50 INFO - PROCESS | 17521 | |4;audio-oscillator;96;97;142;97;97;97;141;96;97;143 23:19:50 INFO - PROCESS | 17521 | |5;imaging-gaussian-blur;109;110;109;109;108;109;109;109;109;108 23:19:50 INFO - PROCESS | 17521 | |6;imaging-darkroom;145;145;145;145;146;146;145;146;145;146 23:19:50 INFO - PROCESS | 17521 | |7;imaging-desaturate;95;96;96;96;96;95;95;96;95;96 23:19:50 INFO - PROCESS | 17521 | |8;json-parse-financial;56;55;57;55;56;56;56;65;54;53 23:19:50 INFO - PROCESS | 17521 | |9;json-stringify-tinderbox;67;67;66;67;68;68;68;67;67;66 23:19:50 INFO - PROCESS | 17521 | |10;stanford-crypto-aes;87;86;87;85;85;84;86;87;87;84 23:19:50 INFO - PROCESS | 17521 | |11;stanford-crypto-ccm;119;116;116;120;120;126;127;125;117;120 23:19:50 INFO - PROCESS | 17521 | |12;stanford-crypto-pbkdf2;142;142;154;153;153;141;151;161;161;139 23:19:50 INFO - PROCESS | 17521 | |13;stanford-crypto-sha256-iterative;71;69;70;68;70;70;67;68;69;70 23:19:50 INFO - PROCESS | 17521 | __end_tp_report 23:19:50 INFO - PROCESS | 17521 | __start_cc_report 23:19:50 INFO - PROCESS | 17521 | _x_x_mozilla_cycle_collect,952 23:19:50 INFO - PROCESS | 17521 | __end_cc_report 23:19:50 INFO - PROCESS | 17521 | __startTimestamp1452064790074__endTimestamp 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | ------- Summary: start ------- 23:19:50 INFO - PROCESS | 17521 | Number of tests: 14 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.43 (4.0%) stddev-sans-first:4.69 23:19:50 INFO - PROCESS | 17521 | Values: 108.0 111.0 103.0 108.0 111.0 111.0 100.0 112.0 110.0 115.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:154.50 stddev:16.15 (10.4%) stddev-sans-first:16.79 23:19:50 INFO - PROCESS | 17521 | Values: 154.0 126.0 152.0 163.0 129.0 156.0 155.0 128.0 163.0 124.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 23:19:50 INFO - PROCESS | 17521 | Values: 161.0 161.0 161.0 163.0 161.0 162.0 160.0 163.0 162.0 162.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.50 stddev:17.43 (23.4%) stddev-sans-first:18.05 23:19:50 INFO - PROCESS | 17521 | Values: 72.0 76.0 81.0 93.0 73.0 70.0 73.0 126.0 93.0 71.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:97.00 stddev:21.88 (22.6%) stddev-sans-first:22.59 23:19:50 INFO - PROCESS | 17521 | Values: 96.0 97.0 142.0 97.0 97.0 97.0 141.0 96.0 97.0 143.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:19:50 INFO - PROCESS | 17521 | Values: 109.0 110.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 108.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:19:50 INFO - PROCESS | 17521 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:19:50 INFO - PROCESS | 17521 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:3.27 (5.8%) stddev-sans-first:3.46 23:19:50 INFO - PROCESS | 17521 | Values: 56.0 55.0 57.0 55.0 56.0 56.0 56.0 65.0 54.0 53.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 23:19:50 INFO - PROCESS | 17521 | Values: 67.0 67.0 66.0 67.0 68.0 68.0 68.0 67.0 67.0 66.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.50 stddev:1.23 (1.4%) stddev-sans-first:1.22 23:19:50 INFO - PROCESS | 17521 | Values: 87.0 86.0 87.0 85.0 85.0 84.0 86.0 87.0 87.0 84.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.00 stddev:4.06 (3.4%) stddev-sans-first:4.27 23:19:50 INFO - PROCESS | 17521 | Values: 119.0 116.0 116.0 120.0 120.0 126.0 127.0 125.0 117.0 120.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:153.00 stddev:8.21 (5.4%) stddev-sans-first:8.22 23:19:50 INFO - PROCESS | 17521 | Values: 142.0 142.0 154.0 153.0 153.0 141.0 151.0 161.0 161.0 139.0 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - PROCESS | 17521 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:70.00 stddev:1.23 (1.8%) stddev-sans-first:1.12 23:19:50 INFO - PROCESS | 17521 | Values: 71.0 69.0 70.0 68.0 70.0 70.0 67.0 68.0 69.0 70.0 23:19:50 INFO - PROCESS | 17521 | -------- Summary: end -------- 23:19:50 INFO - PROCESS | 17521 | 23:19:50 INFO - TEST-INFO | 17521: exit 0 23:19:50 INFO - TEST-OK | kraken | took 58548ms 23:19:50 INFO - TEST-START | v8_7 23:19:50 INFO - operating with platform_type : linux_ 23:19:50 INFO - Initialising browser for v8_7 test... 23:19:51 INFO - TEST-INFO | started process 17770 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBm4797/profile http://localhost:33273/getInfo.html) 23:19:54 INFO - PROCESS | 17770 | __metrics Screen width/height:1600/1200 23:19:54 INFO - PROCESS | 17770 | colorDepth:24 23:19:54 INFO - PROCESS | 17770 | Browser inner width/height: 1024/697 23:19:54 INFO - PROCESS | 17770 | __metrics 23:19:54 INFO - PROCESS | 17770 | 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:19:54 INFO - PROCESS | 17770 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:19:55 INFO - TEST-INFO | 17770: exit 0 23:19:55 INFO - Browser initialized. 23:19:55 INFO - Running cycle 1/1 for v8_7 test... 23:19:55 INFO - TEST-INFO | started process 17856 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBm4797/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:07 INFO - PROCESS | 17856 | RSS: Main: 150265856 23:20:07 INFO - PROCESS | 17856 | 23:20:28 INFO - PROCESS | 17856 | Cycle 1(1): loaded http://localhost:33273/tests/v8_7/run.html (next: http://localhost:33273/tests/v8_7/run.html) 23:20:29 INFO - PROCESS | 17856 | RSS: Main: 629657600 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | __start_tp_report 23:20:29 INFO - PROCESS | 17856 | _x_x_mozilla_page_load 23:20:29 INFO - PROCESS | 17856 | _x_x_mozilla_page_load_details 23:20:29 INFO - PROCESS | 17856 | |i|pagename|runs| 23:20:29 INFO - PROCESS | 17856 | |0;Richards;166.44474034620507 23:20:29 INFO - PROCESS | 17856 | |1;DeltaBlue;191.0949742021785 23:20:29 INFO - PROCESS | 17856 | |2;Encrypt;280.50490883590464 23:20:29 INFO - PROCESS | 17856 | |3;Decrypt;5175.257731958763 23:20:29 INFO - PROCESS | 17856 | |4;RayTrace;1132.5028312570782 23:20:29 INFO - PROCESS | 17856 | |5;Earley;787.4015748031496 23:20:29 INFO - PROCESS | 17856 | |6;Boyer;12108.43373493976 23:20:29 INFO - PROCESS | 17856 | |7;RegExp;25871.79487179487 23:20:29 INFO - PROCESS | 17856 | |8;Splay;652.3716699155295 23:20:29 INFO - PROCESS | 17856 | |9;NavierStokes;4835.748792270531 23:20:29 INFO - PROCESS | 17856 | __end_tp_report 23:20:29 INFO - PROCESS | 17856 | __startTimestamp1452064829167__endTimestamp 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | ------- Summary: start ------- 23:20:29 INFO - PROCESS | 17856 | Number of tests: 10 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 166.4 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 191.1 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 280.5 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 5175.3 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#4] RayTrace Cycles:1 Average:1132.50 Median:1132.50 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 1132.5 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 787.4 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 12108.4 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 25871.8 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#8] Splay Cycles:1 Average:652.37 Median:652.37 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 652.4 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - PROCESS | 17856 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:20:29 INFO - PROCESS | 17856 | Values: 4835.7 23:20:29 INFO - PROCESS | 17856 | -------- Summary: end -------- 23:20:29 INFO - PROCESS | 17856 | 23:20:29 INFO - TEST-INFO | 17856: exit 0 23:20:29 INFO - TEST-OK | v8_7 | took 38949ms 23:20:29 INFO - SUITE-END | took 1210s 23:20:30 INFO - Completed test suite (00:20:10) 23:20:30 INFO - Working with test: dromaeo_css 23:20:30 INFO - Generating results file: dromaeo_css 23:20:30 INFO - Working with test: kraken 23:20:30 INFO - Generating results file: kraken 23:20:30 INFO - javascript benchmark 23:20:30 INFO - Working with test: v8_7 23:20:30 INFO - Generating results file: v8_7 23:20:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:20:30 INFO - process_Request line: dromaeo_css 6889.69 graph.html#tests=[[72,64,35]] 23:20:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:30 INFO - process_Request line: kraken 1507.20 graph.html#tests=[[232,64,35]] 23:20:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:30 INFO - process_Request line: v8_7 20821.63 graph.html#tests=[[230,64,35]] 23:20:30 INFO - RETURN: dromaeo_css: 6889.69 23:20:30 INFO - RETURN: kraken: 1507.20 23:20:30 INFO - RETURN: v8_7: 20821.63 23:20:30 INFO - javascript benchmark 23:20:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3161.9723589833307, 3182.6339970903355, 3224.854881530331, 3228.2252259457737, 3255.9674403255967, 4993.6254780891395, 5121.769520371583, 5171.0950583647855, 5186.611004174688, 5219.399769026563, 5227.085260079481, 5260.184671375943, 5289.629725919187, 5301.628885977983, 5354.14333706607, 4786.808527658898, 4801.73590452525, 4813.518648135176, 4875.902481950359, 4879.975600121995, 4637.86086417408, 4859.149648811462, 4907.2148456247005, 4924.655274130812, 4970.552650261476, 4722.268048452495, 4785.090832741786, 4830.178869592178, 4863.367762190928, 4877.170880950247, 4760.619150467989, 4762.809487620491, 4764.547368000034, 4770.904581908377, 4799.424069111729, 4622.768861556909, 4724.95275047252, 4755.310479980383, 4778.331033655291, 4800.207965685658, 4979.278004689299, 4987.775550100254, 4992.2511623256805, 5005.874853128665, 5018.64869459138, 5469.343678758574, 5470.972645136749, 5538.446155384469, 5556.527695145917, 5566.443355664442, 5712.200291959129, 5726.055200891889, 5728.713564321809, 5733.569982251348, 5734.025215713297, 5109.642325037212, 5330.1205301125265, 5338.866528336784, 5341.038613049611, 5346.144616861284, 5490.203920431515, 5527.032769265363, 5717.628354156966, 5826.242588463558, 5852.795152169739, 5521.199426083195, 5550.72246387679, 5554.861128471821, 5596.636218645775, 5603.719814009283, 5613.382527921925, 5657.43425657431, 5671.9716401418555, 5676.148577713376, 5676.574256930664, 5474.452554744574, 5575.581831362664, 5581.804636837691, 5602.187682785973, 5711.143328500758, 5680.68756218412, 5689.0, 5698.6580805151825, 5716.314042314865, 5736.885262294731, 4417.933730994037, 4426.800793964279, 4427.5572442755465, 4430.800613972379, 4466.59800617946, 3809.2191100824266, 3874.089588946595, 3889.4943657324366, 3957.0, 3969.166475040216, 5272.736363181825, 5280.9207861882105, 5283.815066472655, 5307.442718514578, 5327.653702509325, 5580.19087232349, 5622.212890195376, 5623.493885550321, 5633.887322253532, 5658.688772117491, 5063.240513922941, 5108.106081435734, 5153.252778347119, 5271.578273738091, 5327.067763141435, 4818.156822556039, 4876.975615121902, 4879.316895634614, 4882.194437917775, 4925.261210818406, 5738.397468265855, 5790.536757059425, 5796.3913789052385, 5807.593468457252, 5842.649441033552, 5500.834974950758, 5594.272744543347, 5601.551875850004, 5604.747786349705, 5619.831405057855, 5834.795782147774, 5876.6180198286975, 5921.348651648402, 5927.881442371215, 5962.791302304398, 5612.242347283064, 5614.21401003868, 5618.438156184349, 5635.154726791015, 5644.463775941279, 5515.669059856422, 5557.499825015768, 5613.242212301287, 5758.1362795581, 5764.682942438206, 5543.584231182596, 5613.747381367766, 5616.747246374005, 5622.072358060874, 5655.547556195576, 5477.4796394342475, 5550.195221692913, 5551.8889622208135, 5557.499825015768, 5561.6663000220115, 5194.766235519335, 5290.44450332725, 5298.8940221196135, 5447.428020057837, 5512.228288039598, 5499.065158922913, 5563.221149039218, 5570.136628822539, 5617.606767526398, 5617.943820561742, 5432.130859062531, 5455.781768729206, 5464.836054918359, 5466.316710411199, 5477.0], "unit": "score", "name": "dojo.html", "value": 5199.960950277283}, {"lowerIsBetter": false, "replicates": [520.4327283261247, 533.7891532844526, 534.3107391465011, 538.2518299563604, 558.4499268220802, 28084.297892552695, 28942.421151576957, 28957.56563651547, 28979.130626081223, 35881.46177807335, 39351.0, 39792.60207397925, 39877.202455950865, 39891.20217595647, 39916.20167596646, 8513.829723405528, 8679.609417576225, 8681.913180868174, 8682.392232543725, 8691.60887760049, 7525.134609519921, 7726.111497177812, 10089.495525223747, 10358.689239322795, 10374.688759337232, 10044.949775251114, 10139.34094283873, 10140.340877842953, 10155.492225388738, 10167.796644067113, 7476.289752473506, 7675.654595543214, 10029.197664186848, 10105.04002119801, 10132.341397809156, 10046.246531510165, 10369.0, 10374.118199952938, 10374.325668831501, 10386.169106471463, 37080.44379334312, 37409.25181496355, 37489.06277343088, 37502.4997000359, 37557.0, 3146.7639927005566, 3176.28533579945, 3320.286138480214, 3514.38498262803, 3590.874319398835, 28490.145295640956, 28862.0, 28912.0, 29363.706362936526, 30745.692543074507, 4001.919961600752, 4003.0, 4075.857344992911, 4081.571434999312, 4204.558521355275, 221517.0, 223362.0, 223502.0, 223575.99999999837, 223802.0, 51619.48380516222, 53246.73376633092, 56021.43978560244, 56413.71793141008, 61478.0, 55803.441965580634, 56141.71929140328, 56148.0, 56244.0, 56248.43751562514, 14149.575512734635, 14293.57119286423, 14305.0, 14326.856731432761, 14348.784768228485, 10487.94756026215, 10495.107915827088, 10542.156627469783, 10545.050945414949, 10557.049865512141, 19708.901455492633, 20661.483462913246, 20684.793152068287, 20691.585888328256, 20732.58534829295, 7625.0, 7742.6902923883545, 7763.107242667053, 7940.801479963047, 7979.162187970295, 872.9650813967497, 884.5002573545926, 893.3344658229661, 914.492456686532, 935.8034812689411, 26057.60913586298, 26085.869570652027, 26307.342316442242, 26361.209163725118, 26467.735322646913, 943.2926403210212, 979.7697541077841, 1011.1152741351318, 1091.165258577189, 1109.5728144664201, 14200.786988195185, 14514.0, 14538.927305363406, 14701.926490367694, 14743.926280368743, 383333.0, 390401.0, 391531.0, 392108.0, 392523.0, 54548.72725636346, 55478.445215548134, 55500.44499554953, 55552.16671749927, 55584.444155557925, 1269.2321145706899, 1309.7773378525674, 1321.6563693439582, 1323.3052647360214, 1329.8071779591905, 26382.340441489116, 27150.0, 27837.582436263878, 27864.442711146068, 27992.58011129794, 44689.0, 45395.09209815719, 45485.5885808559, 45507.0, 45576.31635525536, 301674.0, 301893.0, 303181.0, 304375.0, 305657.0, 27646.0, 28315.0, 31420.0, 32352.83823580867, 32716.055555000163, 36672.449913251854, 37160.256794864494, 37206.0, 37491.43762843505, 37697.2460550793, 32513.512297316032, 32595.674043259263, 32739.508907366886, 32957.835210823796, 33017.0, 29749.851250743606, 31938.20154496156, 32646.34707305888, 34395.484067739504, 37085.62914370822, 31830.204244894063, 32438.189045274055, 32671.836640816644, 32676.83661581677, 32727.0, 27728.861355693094, 28570.285742856595, 30348.089557313317, 31386.21534461657, 31855.203619909687, 23394.532109358057, 24040.87979560091, 24190.395240119138, 24438.755612444358, 24452.51094978126], "unit": "score", "name": "ext.html", "value": 17928.136375326874}, {"lowerIsBetter": false, "replicates": [356.819805997971, 360.4971065363816, 363.086836605936, 364.5734490645944, 366.51070820454686, 14048.297585120754, 14217.084670549553, 16081.597960050989, 16440.83559164408, 17015.14924253787, 15688.686226275468, 15992.76010859838, 16336.428225012127, 16461.91769041153, 16495.752563711525, 5220.738963051851, 5366.892662146754, 5367.087595108841, 5369.355677318707, 5369.973150134244, 4022.0, 4162.209180255742, 5359.9732001339935, 5412.648177868446, 5657.264555607786, 5756.424357564252, 5791.536677065846, 5791.681457519835, 5793.536517078624, 5803.21656576361, 5656.971715141419, 5768.307803063659, 5775.971120144372, 5805.100209467518, 5815.941840581582, 5107.616928730323, 5124.769385377667, 5141.76862041209, 5142.665726727788, 5143.305653736773, 20452.386428407022, 20948.5810283795, 20952.790472095236, 21038.894805525873, 21383.358499244892, 2082.9270975515783, 2085.0200405809246, 2119.7456305243313, 2203.7575866654656, 2362.3739708977137, 12971.935140324333, 13196.538121165713, 13290.202587844664, 13450.858969236955, 13476.93261533686, 1754.5789010637482, 1767.2930827668906, 1797.4787311679597, 1878.5585387433941, 1914.2438736698925, 54977.72511137459, 58463.70768146175, 58584.0, 58591.414085859025, 59358.703206484555, 9849.901500985041, 9853.950730246303, 10099.242556808269, 10099.848502272473, 10159.136473399696, 13204.933975330061, 13215.141015834133, 13217.140885842582, 13221.867781322064, 13242.404091815892, 7445.069366329209, 7445.739399121005, 7455.7017719290625, 7515.286047825557, 7567.9243207567215, 7175.17485489165, 7184.245654206337, 7234.0, 7236.167840698282, 7243.927560724431, 5964.135200396005, 6006.459418652343, 6030.638161710312, 6031.487323577545, 6067.969660151671, 1655.6771429571118, 1709.7862767154106, 1710.2987775012186, 1719.6388758360883, 1756.244814729653, 898.5552151684827, 911.4850109688005, 983.0759086458706, 1047.7328281288223, 1054.1408751867205, 16118.838811611733, 16244.0, 16807.41174058902, 17331.913340433217, 17601.91199044022, 871.3639043498282, 871.9869201961976, 872.9519876406858, 897.6005677473462, 928.0811996123924, 9211.447313161232, 9677.0, 10181.134603558632, 10187.949060254652, 10243.84634230487, 385540.0, 391387.0, 392430.0, 392756.0, 393275.0, 74952.0, 76590.23409765943, 76830.61584692041, 76946.61526692443, 77695.0, 1139.8746137924823, 1157.5080590748898, 1158.2818652435544, 1160.158884808524, 1160.7504386556932, 15814.841851581337, 15839.128847913475, 15868.2065896707, 15881.444149454714, 16057.518274451784, 34042.489362659086, 34174.487382688785, 34219.0, 35081.298374032885, 35836.10409739673, 44930.55069449394, 45677.54322456733, 45683.0, 45956.7702161487, 46412.30381544347, 9613.423194608346, 9717.076877696607, 9822.901770982198, 9859.802803943738, 9870.506474676382, 14076.648083797987, 16329.591760206089, 17325.220365083853, 17627.294908203527, 17668.381606643707, 12156.75686486283, 12323.075769317516, 13195.538156164488, 14397.568072957829, 14541.12753234767, 13993.580192594238, 14700.779488307899, 14784.260786960824, 14885.330160143036, 15305.540833775005, 12124.333161676192, 14663.633409164857, 15390.230488475756, 15412.614684632974, 15849.603759905633, 9311.255099591881, 9580.18568421692, 9744.853827192455, 9747.707568772948, 9822.165115965223, 10459.529321180717, 12572.685682858002, 14070.155790652185, 14196.503122390666, 14600.152970170715], "unit": "score", "name": "jquery.html", "value": 8892.044509140203}, {"lowerIsBetter": false, "replicates": [1287.6909541709992, 1412.3009110490307, 1423.5088894331454, 1560.6176486760746, 1770.0795586295135, 6555.573887697296, 7246.166690830556, 7335.266473352662, 7342.522736022155, 7344.706211751523, 7036.964815175917, 7223.566586004843, 7225.169105552863, 7233.348998590126, 7237.529560578572, 1931.6812725900209, 1944.9805501945011, 1963.7643482782087, 1974.6149500847268, 2185.3771675072608, 2259.53679495703, 2267.4444761033487, 2269.7616750241236, 2270.2621647964397, 2271.5116250006245, 2113.651247544153, 2176.9455763605956, 2192.3642143778284, 2197.505561248722, 2198.626233540294, 1907.6661584222775, 1945.0566475259488, 2017.1225516900122, 2058.87646741196, 2064.370367038053, 2155.6874253233195, 2160.5786871560053, 2176.0, 2182.2034957240653, 2183.290430610058, 7262.709491620329, 7361.6319184040585, 7362.484626076177, 7368.705251789922, 7371.115466144043, 4467.463904331468, 4516.390287311204, 4538.069695712371, 4544.568266014723, 4546.272596384596, 2801.649793775778, 2893.6382952130984, 2908.389238259968, 2916.460454815866, 2921.839298838563, 947.2280091725222, 954.5418199264392, 960.188640598693, 985.393982700634, 997.4015590645627, 10288.79422411555, 10291.794164116676, 10303.639372621998, 10307.94846025765, 10315.123214526699, 3931.5871833457077, 4003.819828107742, 4142.565030671796, 4158.126793373425, 4199.832006719758, 8982.775430614287, 8997.055309192441, 9001.234895033864, 9007.324450666096, 9013.729588112366, 4427.380166776654, 4430.357598148251, 4442.067165895133, 4444.666650001198, 4457.598816106566, 4109.0959988802415, 4113.85601503946, 4117.526484454266, 4121.9587804122175, 4124.9587504125175, 3508.0241467838923, 3532.4171511700797, 3532.434810430319, 3576.338377400189, 3580.606133325332, 1108.6895669212633, 1109.1514991031868, 1117.4245263689206, 1122.938238396896, 1124.4602590756483, 919.4575200631659, 934.4299977014016, 941.712777602824, 948.9430634161972, 1064.6114168328659, 6356.841078973062, 6952.130983627047, 7108.431325493948, 7110.146782386147, 7128.821779455555, 597.1132867691562, 608.796053322142, 610.9663968481688, 611.0376157551785, 623.3735096228262, 5614.073677843192, 5675.57433192504, 5682.0, 5705.857353566194, 5717.371089180187, 8726.0, 8981.730548083568, 9020.097990200928, 9036.23192028685, 9125.45247285165, 9009.459432434074, 9130.406523575946, 9141.405808622418, 9162.22121119699, 9177.449353038839, 6918.723251070001, 7172.390346820579, 7176.892346614805, 7205.92794072063, 7245.094363204494, 6892.517523773488, 6937.930620693728, 6965.79102626922, 6968.860622787617, 6969.965150174216, 7989.480683755537, 8123.75628731139, 8140.348772098337, 8145.470544414594, 8272.503649781032, 8215.219554142346, 8217.096119426978, 8333.833323333378, 8336.87494687568, 8344.040435349769, 6525.8694826104165, 6681.899771503528, 6685.130932978682, 6689.899651505329, 6697.0, 6906.585604863523, 6924.515283930076, 6931.1682598088555, 6940.27127151662, 6948.444124469929, 6658.83352916181, 6758.256591774999, 6758.763443279461, 6885.586864788129, 6889.448844092561, 6501.284858665448, 6588.40704336612, 6663.133792607124, 6792.66036698173, 6854.246032936273, 6802.251752307143, 6837.247902730795, 6876.724931002704, 6881.208661004049, 6895.793126206222, 6395.296517383177, 6412.422881940648, 6431.646259455588, 6436.645984470899, 6443.581167224303, 6233.2208473940755, 6241.032639940817, 6289.528285378524, 6292.2134733158355, 6312.6528040956355], "unit": "score", "name": "mootools.html", "value": 4214.023540299895}, {"lowerIsBetter": false, "replicates": [318.38074944233466, 319.62444128149417, 321.3027729826277, 331.9385913605983, 333.20530534674793, 5951.13708512266, 5971.880562388749, 5980.730867110985, 6001.909971350422, 6004.0, 5688.744006519706, 5744.109663002241, 5800.854978625536, 5883.352831188566, 5907.143464197688, 4540.795664195102, 4546.613537849286, 4553.977230113845, 4560.8859778505475, 4561.56665116815, 4381.277089280265, 4556.476005259405, 4567.08658268346, 4572.474165470981, 4572.679912406133, 4434.201843668138, 4434.512203657595, 4519.367288579601, 4519.548045195487, 4532.09358128374, 4493.662975276868, 4493.865184044451, 4511.729296242236, 4514.458265008204, 4530.70550414222, 4019.2363450944226, 4026.2148880968225, 4026.959730402688, 4027.154297597479, 4038.676905847525, 5554.585501404358, 5676.290463692038, 5678.801241956553, 5680.0627896397045, 5693.231413759131, 5325.387580428262, 5329.360476742816, 5338.599605029638, 5340.62615616907, 5342.626016178869, 6280.717367718418, 6304.716287767062, 6306.274778400497, 6307.590006649553, 6314.368563143695, 4462.509123996358, 4465.6650751193465, 4466.062126953344, 4466.1067786442845, 4471.23988921884, 6400.327965563595, 6501.057346684752, 6554.377334153248, 6591.4397276231575, 6596.175478065194, 4592.10453961481, 4594.5864872161665, 4595.6783025187915, 4596.172688916027, 4600.21796294624, 4651.4418269807165, 4656.115338085753, 4660.743659098782, 4662.160811053975, 4663.253879379283, 5310.176922577007, 5324.281222034976, 5333.866653333697, 5337.599680024014, 5337.772312368177, 6153.261608606996, 6334.588251763621, 6338.936610633835, 6344.49244060474, 6361.777337793155, 1600.7038697840937, 1610.0500704584351, 1610.2351383092937, 1612.4114698135331, 1612.475945317753, 1098.4397957041806, 1107.197281970565, 1109.606089838112, 1117.5976648406568, 1130.9547618095185, 6008.24896887889, 6013.30846952606, 6015.097735339734, 6020.247469066367, 6028.969855150696, 6499.837504062341, 6511.544191906616, 6514.3811337922825, 6515.120458738104, 6521.184851893513, 5784.1008459505765, 5815.563832712563, 5953.672548009901, 6028.577999540078, 6057.333693293822, 3450.1547120955524, 3497.213127046394, 3500.807455589916, 3501.77238479498, 3503.579570451562, 6709.899351509731, 6814.727410903607, 6818.761343352959, 6825.658717064226, 6831.146106736658, 6758.831029224309, 6764.729410823512, 6768.76309329181, 6773.153355830521, 6778.084958530634, 6617.371349721769, 6661.4337781287195, 6777.762778302835, 6805.6597170141295, 6814.557053791487, 6537.248216455168, 6541.383446621389, 6545.934540654533, 6547.770828020996, 6549.574277671936, 6457.935420645921, 6482.092507048923, 6484.481241500763, 6485.513586480938, 6490.0, 6614.536982411378, 6780.627065511444, 6787.287334829772, 6791.286914874065, 6795.0, 4591.540845915515, 4595.058013107372, 4598.241290187082, 4600.907981840412, 4603.608693261111, 6567.474602031922, 6568.770093046721, 6573.57271777333, 6573.934260657332, 6582.637954912526, 6222.28443728977, 6389.9361006389345, 6421.133147025279, 6434.388733070351, 6436.774712885027, 6388.616682999035, 6406.0390941359165, 6414.486841052798, 6419.197600299963, 6421.325760795049, 6298.9921612541775, 6299.779507717208, 6301.212348456443, 6305.274893387319, 6305.873882522415, 6244.063390491463, 6453.548251622529, 6461.64460954652, 6462.579932304385, 6465.612063276219, 6044.455998960115, 6148.631082135086, 6190.566660333733, 6281.560290779602, 6298.535805306971], "unit": "score", "name": "prototype.html", "value": 4786.740429879748}, {"lowerIsBetter": false, "replicates": [730.4485113739127, 732.3408931961234, 790.9446338756286, 808.5997431271521, 830.0827585518002, 13031.022673299505, 13295.933520332408, 13364.532241371555, 13473.124246923955, 13506.257155856423, 14911.0, 15276.618084547892, 15296.31166597503, 15302.540923772276, 15311.310991005405, 683.7880257120308, 694.1982010777534, 700.3906601256888, 834.5368320582074, 842.2756429470651, 829.2495291760966, 846.4540371460404, 851.8637018077109, 852.40757673417, 852.722865068852, 883.5361435246483, 883.6774577279278, 887.4941283468426, 887.8313120507083, 888.9199972002518, 723.027527974873, 731.893875388071, 873.1966590736538, 875.4309698695866, 891.5809569502388, 651.1730102769457, 651.2347991110427, 651.5406638319973, 651.7718798420563, 652.3215855510264, 13805.378757955816, 13913.930430347884, 13935.954803389684, 13948.860511394858, 13956.72086558263, 12606.621801345975, 12998.740025199442, 13051.86948130516, 13092.214467132002, 13524.797128043087, 9948.154406875425, 10444.79110417795, 10488.265821392506, 10625.787484250272, 10718.464076796128, 3613.5483064616924, 3697.6856967157823, 3705.055210921225, 3714.201446688975, 3783.8108094595436, 47206.5279347209, 47262.054758904975, 47697.52302477, 49124.754376228244, 49131.75434122842, 10363.585456581652, 10615.575376984834, 10639.946800265949, 10679.412632305142, 10760.139188864872, 19048.71426928597, 19052.428427147206, 19161.616767664567, 19207.231710731416, 19224.231030758612, 7611.619419029026, 7826.686932522749, 7902.0, 7919.089304729914, 7928.5242885425905, 4415.205263052617, 4553.567411095941, 4589.4722106958125, 4635.768211589474, 4701.106789709944, 3082.090783218956, 3116.844157792101, 3122.718955293989, 3123.54708567261, 3125.718685318332, 535.5073332534, 549.4313385645837, 555.2199160179954, 558.1794761700294, 565.2115299157653, 627.8304857688398, 648.2933602373436, 658.6937074260492, 683.8427161752825, 691.6368906324119, 8574.614142363609, 8666.826663466696, 8795.956020219857, 8812.8678069829, 8892.377533572717, 611.4924612571555, 618.4032408725601, 654.1153513007614, 659.6306068601599, 666.8399584099781, 4151.12826306473, 4218.49378074633, 4255.361695745601, 4276.444062271947, 4414.139242847678, 53552.19671704849, 53830.0, 54123.72938135284, 54204.0, 55075.72462137744, 49634.50365496371, 50055.49944500509, 50065.49934500609, 50131.74934125306, 50308.496915031115, 43218.0, 44389.77805110954, 44452.777736111115, 44743.32885006727, 45726.77136614296, 8270.710525131592, 8271.22168733725, 8356.456830306011, 8402.865613142147, 8506.362022848434, 34931.650683493855, 35507.82246088753, 35609.82195089111, 35757.82121089378, 36136.63863361333, 41236.0, 44235.55764442443, 44337.0, 44604.0, 47758.07612346024, 10954.287971281841, 11027.724306892393, 11137.888621113685, 11304.0, 11448.427578621202, 12231.327276999851, 12519.499220031097, 12642.747145056863, 13072.215667060007, 13088.738225235633, 11079.833802492807, 11364.147688923198, 11527.942360288145, 11754.23597466162, 11774.82337764917, 11290.266132701348, 11384.943075284571, 11439.828402573801, 11726.589569365031, 11922.403879806148, 10757.1932105094, 11010.50452729613, 11102.333859968428, 11444.427778611203, 11551.653450396501, 9594.280428967715, 9847.63049774702, 9941.403515789076, 10147.695569132939, 10497.370157790558, 8754.242313998484, 9005.459672419676, 9611.327207095435, 9883.851742224017, 10131.392116473035], "unit": "score", "name": "yui.html", "value": 6395.651060470795}], "name": "dromaeo_css", "value": 6889.691105534748}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 103.0, 108.0, 111.0, 111.0, 100.0, 112.0, 110.0, 115.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 152.0, 163.0, 129.0, 156.0, 155.0, 128.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 163.0, 161.0, 162.0, 160.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 81.0, 93.0, 73.0, 70.0, 73.0, 126.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 97.0, 97.0, 97.0, 141.0, 96.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 57.0, 55.0, 56.0, 56.0, 56.0, 65.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 87.0, 85.0, 85.0, 84.0, 86.0, 87.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 116.0, 120.0, 120.0, 126.0, 127.0, 125.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 154.0, 153.0, 153.0, 141.0, 151.0, 161.0, 161.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 68.0, 70.0, 70.0, 67.0, 68.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1507.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1132.5028312570782], "unit": "score", "name": "RayTrace", "value": 653.410287}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [652.3716699155295], "unit": "score", "name": "Splay", "value": 124.91498904382466}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20821.63012723121}]} 23:20:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20821.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1507.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6889.69"}}} 23:20:30 INFO - Return code: 0 23:20:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:20:30 INFO - # TBPL SUCCESS # 23:20:30 INFO - Running post-action listener: _resource_record_post_action 23:20:30 INFO - Running post-run listener: _resource_record_post_run 23:20:31 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 565637120; Read time: 0; Write time: 527880 23:20:31 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255819776; Read time: 0; Write time: 296560 23:20:31 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 309817344; Read time: 0; Write time: 231320 23:20:31 INFO - Running post-run listener: _upload_blobber_files 23:20:31 INFO - Blob upload gear active. 23:20:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:20:31 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:20:31 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:20:31 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:20:32 INFO - (blobuploader) - INFO - Open directory for files ... 23:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:33 INFO - (blobuploader) - INFO - Done attempting. 23:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:33 INFO - (blobuploader) - INFO - Done attempting. 23:20:33 INFO - (blobuploader) - INFO - Iteration through files over. 23:20:33 INFO - Return code: 0 23:20:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:20:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:20:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39af1214d9754f5f0f498c2408fa2a37c3e87f7d361c851946c71a93b337c5d36e18469d2a9dd159eab66b2df475a4c60afaee69da0034bd528a9123dfb56c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d8ae7ab87921c0f9d3b375dce0d7b04062bc98f9fd7396fedba6d34f86209223bd9fe59e0a59b43ab344fe362ed9a8a9af46114357429c41edc30771c63c7cc"} 23:20:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:20:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:20:33 INFO - Contents: 23:20:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39af1214d9754f5f0f498c2408fa2a37c3e87f7d361c851946c71a93b337c5d36e18469d2a9dd159eab66b2df475a4c60afaee69da0034bd528a9123dfb56c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d8ae7ab87921c0f9d3b375dce0d7b04062bc98f9fd7396fedba6d34f86209223bd9fe59e0a59b43ab344fe362ed9a8a9af46114357429c41edc30771c63c7cc"} 23:20:33 INFO - Copying logs to upload dir... 23:20:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.922105 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-05 23:20:33.442347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:33.445764) ========= 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=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39af1214d9754f5f0f498c2408fa2a37c3e87f7d361c851946c71a93b337c5d36e18469d2a9dd159eab66b2df475a4c60afaee69da0034bd528a9123dfb56c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d8ae7ab87921c0f9d3b375dce0d7b04062bc98f9fd7396fedba6d34f86209223bd9fe59e0a59b43ab344fe362ed9a8a9af46114357429c41edc30771c63c7cc"} build_url:https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f39af1214d9754f5f0f498c2408fa2a37c3e87f7d361c851946c71a93b337c5d36e18469d2a9dd159eab66b2df475a4c60afaee69da0034bd528a9123dfb56c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d8ae7ab87921c0f9d3b375dce0d7b04062bc98f9fd7396fedba6d34f86209223bd9fe59e0a59b43ab344fe362ed9a8a9af46114357429c41edc30771c63c7cc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:33.471417) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:33.471736) ========= 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=ed14279e38b05397cf4aa391000001a4-1452062904.841216-561839293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:33.557106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 23:20:33.557440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 23:20:33.557746) ========= ========= Total master_lag: 0.29 =========