builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1452063569.02 results: success (0) buildid: 20160105203052 builduid: d1128ed623b449a38d22b799b1ecc6e7 revision: 1a9729efc3da75a85714f20c1afd471b9e684dfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.017235) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.017767) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.018184) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006376 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.043436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.043865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.068957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.069221) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019735 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.121409) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.121718) ========= 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:29.122104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.122397) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 22:59:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-05 22:59:29 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138536 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.273420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.273717) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.064492 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.349081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.349432) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 22:59:29,355 truncating revision to first 12 chars 2016-01-05 22:59:29,355 Setting DEBUG logging. 2016-01-05 22:59:29,355 attempt 1/10 2016-01-05 22:59:29,355 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:29,597 unpacking tar archive at: fx-team-1a9729efc3da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.893025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.893407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.901174) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 22:59:29.901523) ========= 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:29.901924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-05 22:59:29.902246) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:59:30 INFO - MultiFileLogger online at 20160105 22:59:30 in /builds/slave/test-pgo 22:59:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:59:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:59:30 INFO - {'append_to_log': False, 22:59:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:59:30 INFO - 'blob_upload_branch': 'Fx-Team', 22:59:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:59:30 INFO - 'branch': 'Fx-Team', 22:59:30 INFO - 'buildbot_json_path': 'buildprops.json', 22:59:30 INFO - 'config_files': ('talos/linux_config.py',), 22:59:30 INFO - 'default_actions': ('clobber', 22:59:30 INFO - 'read-buildbot-config', 22:59:30 INFO - 'download-and-extract', 22:59:30 INFO - 'populate-webroot', 22:59:30 INFO - 'create-virtualenv', 22:59:30 INFO - 'install', 22:59:30 INFO - 'run-tests'), 22:59:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:59:30 INFO - 'download_minidump_stackwalk': True, 22:59:30 INFO - 'download_symbols': 'ondemand', 22:59:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:59:30 INFO - 'tooltool.py': '/tools/tooltool.py', 22:59:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:59:30 INFO - '/tools/misc-python/virtualenv.py')}, 22:59:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:59:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:59:30 INFO - 'installer_path': 'installer.exe', 22:59:30 INFO - 'log_level': 'info', 22:59:30 INFO - 'log_name': 'talos', 22:59:30 INFO - 'log_to_console': True, 22:59:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:59:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:59:30 INFO - 'opt_config_files': (), 22:59:30 INFO - 'pip_index': False, 22:59:30 INFO - 'sps_profile': False, 22:59:30 INFO - 'sps_profile_interval': 0, 22:59:30 INFO - 'suite': 'dromaeojs-e10s', 22:59:30 INFO - 'system_bits': '32', 22:59:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:59:30 INFO - 'title': 'talos-linux64-ix-037', 22:59:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:59:30 INFO - 'use_talos_json': True, 22:59:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:59:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:59:30 INFO - 'work_dir': 'build'} 22:59:30 INFO - ##### 22:59:30 INFO - ##### Running clobber step. 22:59:30 INFO - ##### 22:59:30 INFO - Running pre-action listener: _resource_record_pre_action 22:59:30 INFO - Running main action method: clobber 22:59:30 INFO - rmtree: /builds/slave/test-pgo/build 22:59:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:59:34 INFO - Running post-action listener: _resource_record_post_action 22:59:34 INFO - ##### 22:59:34 INFO - ##### Running read-buildbot-config step. 22:59:34 INFO - ##### 22:59:34 INFO - Running pre-action listener: _resource_record_pre_action 22:59:34 INFO - Running main action method: read_buildbot_config 22:59:34 INFO - Using buildbot properties: 22:59:34 INFO - { 22:59:34 INFO - "project": "", 22:59:34 INFO - "product": "firefox", 22:59:34 INFO - "script_repo_revision": "production", 22:59:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:59:34 INFO - "repository": "", 22:59:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:59:34 INFO - "buildid": "20160105203052", 22:59:34 INFO - "pgo_build": "True", 22:59:34 INFO - "basedir": "/builds/slave/test-pgo", 22:59:34 INFO - "buildnumber": 181, 22:59:34 INFO - "slavename": "talos-linux64-ix-037", 22:59:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:59:34 INFO - "platform": "ubuntu64_hw", 22:59:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:59:34 INFO - "branch": "fx-team", 22:59:34 INFO - "repo_path": "integration/fx-team", 22:59:34 INFO - "revision": "1a9729efc3da75a85714f20c1afd471b9e684dfb", 22:59:34 INFO - "stage_platform": "linux64-pgo", 22:59:34 INFO - "builduid": "d1128ed623b449a38d22b799b1ecc6e7", 22:59:34 INFO - "slavebuilddir": "test" 22:59:34 INFO - } 22:59:34 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:34 INFO - Running post-action listener: _resource_record_post_action 22:59:34 INFO - ##### 22:59:34 INFO - ##### Running download-and-extract step. 22:59:34 INFO - ##### 22:59:34 INFO - Running pre-action listener: _resource_record_pre_action 22:59:34 INFO - Running main action method: download_and_extract 22:59:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:34 INFO - https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json 22:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/test_packages.json 22:59:34 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:34 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:36 INFO - Downloaded 1302 bytes. 22:59:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:59:36 INFO - Using the following test package requirements: 22:59:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:59:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:59:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:36 INFO - u'jsshell-linux-x86_64.zip'], 22:59:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:59:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:59:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:59:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:59:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:59:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:59:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:59:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:59:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.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.common.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.common.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.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.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.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:38 INFO - Downloaded 24055577 bytes. 22:59:38 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:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59:38 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:39 INFO - Return code: 0 22:59:39 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:39 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:39 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:39 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:39 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:39 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:39 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:46 INFO - Downloaded 24055577 bytes. 22:59:46 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:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:59:46 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:47 INFO - Return code: 0 22:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:47 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:47 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:47 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:47 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:47 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:48 INFO - Downloaded 11132285 bytes. 22:59:48 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:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:59:48 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:48 INFO - Return code: 0 22:59:48 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:48 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:48 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:48 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:48 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:48 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:50 INFO - Downloaded 55062142 bytes. 22:59:50 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:50 INFO - mkdir: /builds/slave/test-pgo/properties 22:59:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:59:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:59:50 INFO - Contents: 22:59:50 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:50 INFO - Running post-action listener: _resource_record_post_action 22:59:50 INFO - Running post-action listener: set_extra_try_arguments 22:59:50 INFO - ##### 22:59:50 INFO - ##### Running populate-webroot step. 22:59:50 INFO - ##### 22:59:50 INFO - Running pre-action listener: _resource_record_pre_action 22:59:50 INFO - Running main action method: populate_webroot 22:59:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:59:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:59:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:59:50 INFO - '--tppagecycles', 22:59:50 INFO - '7'], 22:59:50 INFO - 'tests': ['tsvgm']}}, 22:59:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:59:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:59:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:59:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:59:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'tests': ['damp', 'tps']}, 22:59:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['damp', 'tps']}, 22:59:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:59:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:59:50 INFO - 'other': {'tests': ['a11yr', 22:59:50 INFO - 'ts_paint', 22:59:50 INFO - 'tpaint', 22:59:50 INFO - 'sessionrestore', 22:59:50 INFO - 'sessionrestore_no_auto_restore']}, 22:59:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['a11yr', 22:59:50 INFO - 'ts_paint', 22:59:50 INFO - 'tpaint', 22:59:50 INFO - 'sessionrestore', 22:59:50 INFO - 'sessionrestore_no_auto_restore']}, 22:59:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['a11yr', 22:59:50 INFO - 'ts_paint', 22:59:50 INFO - 'tpaint', 22:59:50 INFO - 'sessionrestore', 22:59:50 INFO - 'sessionrestore_no_auto_restore']}, 22:59:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['a11yr', 22:59:50 INFO - 'ts_paint', 22:59:50 INFO - 'tpaint', 22:59:50 INFO - 'sessionrestore', 22:59:50 INFO - 'sessionrestore_no_auto_restore']}, 22:59:50 INFO - 'other_l64': {'tests': ['a11yr', 22:59:50 INFO - 'ts_paint', 22:59:50 INFO - 'tpaint', 22:59:50 INFO - 'sessionrestore', 22:59:50 INFO - 'sessionrestore_no_auto_restore']}, 22:59:50 INFO - 'other_nol64': {'tests': ['a11yr', 22:59:50 INFO - 'ts_paint', 22:59:50 INFO - 'tpaint', 22:59:50 INFO - 'sessionrestore', 22:59:50 INFO - 'sessionrestore_no_auto_restore']}, 22:59:50 INFO - 'svgr': {'tests': ['tsvgx', 22:59:50 INFO - 'tsvgr_opacity', 22:59:50 INFO - 'tart', 22:59:50 INFO - 'tscrollx', 22:59:50 INFO - 'cart']}, 22:59:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['tsvgx', 22:59:50 INFO - 'tsvgr_opacity', 22:59:50 INFO - 'tart', 22:59:50 INFO - 'tscrollx', 22:59:50 INFO - 'cart']}, 22:59:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'tests': ['tp5o']}, 22:59:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'talos_options': ['--e10s'], 22:59:50 INFO - 'tests': ['tp5o']}, 22:59:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'talos_options': ['--xperf_path', 22:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:50 INFO - 'tests': ['tp5n']}, 22:59:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:50 INFO - 'talos_options': ['--e10s', 22:59:50 INFO - '--xperf_path', 22:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:50 INFO - 'tests': ['tp5n']}}, 22:59:50 INFO - 'talos.zip': {'path': '', 22:59:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:59:50 INFO - Running post-action listener: _resource_record_post_action 22:59:50 INFO - ##### 22:59:50 INFO - ##### Running create-virtualenv step. 22:59:50 INFO - ##### 22:59:50 INFO - Running pre-action listener: _resource_record_pre_action 22:59:50 INFO - Running main action method: create_virtualenv 22:59:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:59:50 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:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:59:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:59:50 INFO - Using real prefix '/usr' 22:59:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:59:50 INFO - Installing distribute.............................................................................................................................................................................................done. 22:59:52 INFO - Installing pip.................done. 22:59:52 INFO - Return code: 0 22:59:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:59:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:59:52 INFO - Using env: {'DISPLAY': ':0', 22:59:52 INFO - 'HOME': '/home/cltbld', 22:59:52 INFO - 'LANG': 'en_US.UTF-8', 22:59:52 INFO - 'LANGUAGE': 'en_US:en', 22:59:52 INFO - 'LOGNAME': 'cltbld', 22:59:52 INFO - 'MAIL': '/var/mail/cltbld', 22:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:52 INFO - 'MOZ_NO_REMOTE': '1', 22:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:52 INFO - 'NO_EM_RESTART': '1', 22:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:52 INFO - 'SHELL': '/bin/bash', 22:59:52 INFO - 'SHLVL': '1', 22:59:52 INFO - 'TERM': 'linux', 22:59:52 INFO - 'TMOUT': '86400', 22:59:52 INFO - 'USER': 'cltbld', 22:59:52 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 22:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:52 INFO - '_': '/tools/buildbot/bin/python'} 22:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:53 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:53 INFO - Cleaning up... 22:59:53 INFO - Return code: 0 22:59:53 INFO - Installing psutil>=0.7.1 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', '--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 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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', '--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:53 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: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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 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 - Downloading/unpacking psutil>=0.7.1 22:59:53 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:53 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:53 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:53 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:53 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:53 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:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:59:55 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:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:55 INFO - Installing collected packages: psutil 22:59:55 INFO - Running setup.py install for psutil 22:59:55 INFO - building 'psutil._psutil_linux' extension 22:59:55 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:55 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:55 INFO - building 'psutil._psutil_posix' extension 22:59:55 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:55 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:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:55 INFO - Successfully installed psutil 22:59:55 INFO - Cleaning up... 22:59:55 INFO - Return code: 0 22:59:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:55 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 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 22:59:55 INFO - 'HOME': '/home/cltbld', 22:59:55 INFO - 'LANG': 'en_US.UTF-8', 22:59:55 INFO - 'LANGUAGE': 'en_US:en', 22:59:55 INFO - 'LOGNAME': 'cltbld', 22:59:55 INFO - 'MAIL': '/var/mail/cltbld', 22:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:55 INFO - 'MOZ_NO_REMOTE': '1', 22:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:55 INFO - 'NO_EM_RESTART': '1', 22:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:55 INFO - 'SHELL': '/bin/bash', 22:59:55 INFO - 'SHLVL': '1', 22:59:55 INFO - 'TERM': 'linux', 22:59:55 INFO - 'TMOUT': '86400', 22:59:55 INFO - 'USER': 'cltbld', 22:59:55 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 22:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:55 INFO - '_': '/tools/buildbot/bin/python'} 22:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:59:55 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:55 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:55 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:55 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:55 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:55 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 - Downloading mozsystemmonitor-0.0.tar.gz 22:59:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:59:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:59:57 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:57 INFO - Installing collected packages: mozsystemmonitor 22:59:57 INFO - Running setup.py install for mozsystemmonitor 22:59:57 INFO - Successfully installed mozsystemmonitor 22:59:57 INFO - Cleaning up... 22:59:57 INFO - Return code: 0 22:59:57 INFO - Installing blobuploader==1.2.4 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', '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 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 22:59:59 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:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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 - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:00:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:00 INFO - Downloading docopt-0.6.1.tar.gz 23:00:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:00:00 INFO - Installing collected packages: blobuploader, requests, docopt 23:00:00 INFO - Running setup.py install for blobuploader 23:00:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:00:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:00:00 INFO - Running setup.py install for requests 23:00:00 INFO - Running setup.py install for docopt 23:00:00 INFO - Successfully installed blobuploader requests docopt 23:00:00 INFO - Cleaning up... 23:00:00 INFO - Return code: 0 23:00:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:00 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 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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 23:00:00 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 23:00:00 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 23:00:00 INFO - Using env: {'DISPLAY': ':0', 23:00:00 INFO - 'HOME': '/home/cltbld', 23:00:00 INFO - 'LANG': 'en_US.UTF-8', 23:00:00 INFO - 'LANGUAGE': 'en_US:en', 23:00:00 INFO - 'LOGNAME': 'cltbld', 23:00:00 INFO - 'MAIL': '/var/mail/cltbld', 23:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:00 INFO - 'MOZ_NO_REMOTE': '1', 23:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:00 INFO - 'NO_EM_RESTART': '1', 23:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:00 INFO - 'SHELL': '/bin/bash', 23:00:00 INFO - 'SHLVL': '1', 23:00:00 INFO - 'TERM': 'linux', 23:00:00 INFO - 'TMOUT': '86400', 23:00:00 INFO - 'USER': 'cltbld', 23:00:00 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 23:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:00 INFO - '_': '/tools/buildbot/bin/python'} 23:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:01 INFO - Running setup.py (path:/tmp/pip-jYlDeU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:01 INFO - Running setup.py (path:/tmp/pip-Eh7s0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:01 INFO - Running setup.py (path:/tmp/pip-nmMYKx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:01 INFO - Running setup.py (path:/tmp/pip-H77gU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:01 INFO - Running setup.py (path:/tmp/pip-jHx13v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:01 INFO - Running setup.py (path:/tmp/pip-7g7KOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:01 INFO - Running setup.py (path:/tmp/pip-ER8Jaw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:01 INFO - Running setup.py (path:/tmp/pip-8IeMYy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:01 INFO - Running setup.py (path:/tmp/pip-d35hAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:01 INFO - Running setup.py (path:/tmp/pip-4oeaVa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:01 INFO - Running setup.py (path:/tmp/pip-ijmpY5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:01 INFO - Running setup.py (path:/tmp/pip-wdXb0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:02 INFO - Running setup.py (path:/tmp/pip-ss7AiR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:02 INFO - Running setup.py (path:/tmp/pip-CSj2Bb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:02 INFO - Running setup.py (path:/tmp/pip-sYwk5C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:02 INFO - Running setup.py (path:/tmp/pip-XxDYhC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:02 INFO - Running setup.py (path:/tmp/pip-fC0Jxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:00:02 INFO - Running setup.py install for manifestparser 23:00:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:00:02 INFO - Running setup.py install for mozcrash 23:00:02 INFO - Running setup.py install for mozdebug 23:00:02 INFO - Running setup.py install for mozdevice 23:00:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:00:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:00:02 INFO - Running setup.py install for mozfile 23:00:02 INFO - Running setup.py install for mozhttpd 23:00:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Running setup.py install for mozinfo 23:00:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Running setup.py install for mozInstall 23:00:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Running setup.py install for mozleak 23:00:03 INFO - Running setup.py install for mozlog 23:00:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Running setup.py install for moznetwork 23:00:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Running setup.py install for mozprocess 23:00:03 INFO - Running setup.py install for mozprofile 23:00:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Running setup.py install for mozrunner 23:00:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:00:03 INFO - Running setup.py install for mozscreenshot 23:00:03 INFO - Running setup.py install for moztest 23:00:04 INFO - Running setup.py install for mozversion 23:00:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:00:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:00:04 INFO - Cleaning up... 23:00:04 INFO - Return code: 0 23:00:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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 23:00:04 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 23:00:04 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 23:00:04 INFO - Using env: {'DISPLAY': ':0', 23:00:04 INFO - 'HOME': '/home/cltbld', 23:00:04 INFO - 'LANG': 'en_US.UTF-8', 23:00:04 INFO - 'LANGUAGE': 'en_US:en', 23:00:04 INFO - 'LOGNAME': 'cltbld', 23:00:04 INFO - 'MAIL': '/var/mail/cltbld', 23:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:04 INFO - 'MOZ_NO_REMOTE': '1', 23:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:04 INFO - 'NO_EM_RESTART': '1', 23:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:04 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:04 INFO - 'SHELL': '/bin/bash', 23:00:04 INFO - 'SHLVL': '1', 23:00:04 INFO - 'TERM': 'linux', 23:00:04 INFO - 'TMOUT': '86400', 23:00:04 INFO - 'USER': 'cltbld', 23:00:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 23:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:04 INFO - '_': '/tools/buildbot/bin/python'} 23:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:04 INFO - Running setup.py (path:/tmp/pip-eeVrtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:04 INFO - Running setup.py (path:/tmp/pip-Uvda_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:04 INFO - Running setup.py (path:/tmp/pip-jqjlwf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:04 INFO - Running setup.py (path:/tmp/pip-J6WueM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:04 INFO - Running setup.py (path:/tmp/pip-9Wij8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:04 INFO - Running setup.py (path:/tmp/pip-FUOjqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:04 INFO - Running setup.py (path:/tmp/pip-oEQyIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:04 INFO - Running setup.py (path:/tmp/pip-6249Ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:04 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)) 23:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:04 INFO - Running setup.py (path:/tmp/pip-t7pQlA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:05 INFO - Running setup.py (path:/tmp/pip-VAemKr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:05 INFO - Running setup.py (path:/tmp/pip-BlwB2a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:05 INFO - Running setup.py (path:/tmp/pip-RVZwcf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:05 INFO - Running setup.py (path:/tmp/pip-sLYpGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:05 INFO - Running setup.py (path:/tmp/pip-uFhZ8j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:05 INFO - Running setup.py (path:/tmp/pip-C9H7Ca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:05 INFO - Running setup.py (path:/tmp/pip-ZcSoc4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:05 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)) 23:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:05 INFO - Running setup.py (path:/tmp/pip-CXxzxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:05 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)) 23:00:05 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)) 23:00:05 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)) 23:00:05 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)) 23:00:05 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)) 23:00:05 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)) 23:00:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:00:05 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:05 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:05 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:05 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:05 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:05 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:07 INFO - Downloading blessings-1.5.1.tar.gz 23:00:07 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 23:00:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:00:07 INFO - Installing collected packages: blessings 23:00:07 INFO - Running setup.py install for blessings 23:00:07 INFO - Successfully installed blessings 23:00:07 INFO - Cleaning up... 23:00:07 INFO - Return code: 0 23:00:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:00:07 INFO - Reading from file tmpfile_stdout 23:00:07 INFO - Current package versions: 23:00:07 INFO - argparse == 1.2.1 23:00:07 INFO - blessings == 1.5.1 23:00:07 INFO - blobuploader == 1.2.4 23:00:07 INFO - docopt == 0.6.1 23:00:07 INFO - manifestparser == 1.1 23:00:07 INFO - mozInstall == 1.12 23:00:07 INFO - mozcrash == 0.16 23:00:07 INFO - mozdebug == 0.1 23:00:07 INFO - mozdevice == 0.47 23:00:07 INFO - mozfile == 1.2 23:00:07 INFO - mozhttpd == 0.7 23:00:07 INFO - mozinfo == 0.9 23:00:07 INFO - mozleak == 0.1 23:00:07 INFO - mozlog == 3.1 23:00:07 INFO - moznetwork == 0.27 23:00:07 INFO - mozprocess == 0.22 23:00:07 INFO - mozprofile == 0.28 23:00:07 INFO - mozrunner == 6.11 23:00:07 INFO - mozscreenshot == 0.1 23:00:07 INFO - mozsystemmonitor == 0.0 23:00:07 INFO - moztest == 0.7 23:00:07 INFO - mozversion == 1.4 23:00:07 INFO - psutil == 3.1.1 23:00:07 INFO - requests == 1.2.3 23:00:07 INFO - wsgiref == 0.1.2 23:00:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:00:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:07 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 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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 23:00:07 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 23:00:07 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 23:00:07 INFO - Using env: {'DISPLAY': ':0', 23:00:07 INFO - 'HOME': '/home/cltbld', 23:00:07 INFO - 'LANG': 'en_US.UTF-8', 23:00:07 INFO - 'LANGUAGE': 'en_US:en', 23:00:07 INFO - 'LOGNAME': 'cltbld', 23:00:07 INFO - 'MAIL': '/var/mail/cltbld', 23:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:07 INFO - 'MOZ_NO_REMOTE': '1', 23:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:07 INFO - 'NO_EM_RESTART': '1', 23:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:07 INFO - 'SHELL': '/bin/bash', 23:00:07 INFO - 'SHLVL': '1', 23:00:07 INFO - 'TERM': 'linux', 23:00:07 INFO - 'TMOUT': '86400', 23:00:07 INFO - 'USER': 'cltbld', 23:00:07 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 23:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:07 INFO - '_': '/tools/buildbot/bin/python'} 23:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 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)) 23:00:08 INFO - Cleaning up... 23:00:08 INFO - Return code: 0 23:00:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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 23:00:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 23:00:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:00:08 INFO - Using env: {'DISPLAY': ':0', 23:00:08 INFO - 'HOME': '/home/cltbld', 23:00:08 INFO - 'LANG': 'en_US.UTF-8', 23:00:08 INFO - 'LANGUAGE': 'en_US:en', 23:00:08 INFO - 'LOGNAME': 'cltbld', 23:00:08 INFO - 'MAIL': '/var/mail/cltbld', 23:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:08 INFO - 'MOZ_NO_REMOTE': '1', 23:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:08 INFO - 'NO_EM_RESTART': '1', 23:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:08 INFO - 'SHELL': '/bin/bash', 23:00:08 INFO - 'SHLVL': '1', 23:00:08 INFO - 'TERM': 'linux', 23:00:08 INFO - 'TMOUT': '86400', 23:00:08 INFO - 'USER': 'cltbld', 23:00:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 23:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:08 INFO - '_': '/tools/buildbot/bin/python'} 23:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:08 INFO - Downloading/unpacking jsonschema 23:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:00:09 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 23:00:09 INFO - Downloading/unpacking functools32 (from jsonschema) 23:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:10 INFO - Downloading functools32-3.2.3-2.tar.gz 23:00:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:00:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:00:10 INFO - warning: no files found matching '*.txt' 23:00:10 INFO - no previously-included directories found matching 'build' 23:00:10 INFO - no previously-included directories found matching 'dist' 23:00:10 INFO - no previously-included directories found matching '.git*' 23:00:10 INFO - Installing collected packages: jsonschema, functools32 23:00:10 INFO - Running setup.py install for functools32 23:00:10 INFO - warning: no files found matching '*.txt' 23:00:10 INFO - no previously-included directories found matching 'build' 23:00:10 INFO - no previously-included directories found matching 'dist' 23:00:10 INFO - no previously-included directories found matching '.git*' 23:00:10 INFO - Successfully installed jsonschema functools32 23:00:10 INFO - Cleaning up... 23:00:10 INFO - Return code: 0 23:00:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:00:10 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:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:10 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:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:10 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 0x7f461b56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', '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 23:00:10 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 23:00:10 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 23:00:10 INFO - Using env: {'DISPLAY': ':0', 23:00:10 INFO - 'HOME': '/home/cltbld', 23:00:10 INFO - 'LANG': 'en_US.UTF-8', 23:00:10 INFO - 'LANGUAGE': 'en_US:en', 23:00:10 INFO - 'LOGNAME': 'cltbld', 23:00:10 INFO - 'MAIL': '/var/mail/cltbld', 23:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:10 INFO - 'MOZ_NO_REMOTE': '1', 23:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:10 INFO - 'NO_EM_RESTART': '1', 23:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:10 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:10 INFO - 'SHELL': '/bin/bash', 23:00:10 INFO - 'SHLVL': '1', 23:00:10 INFO - 'TERM': 'linux', 23:00:10 INFO - 'TMOUT': '86400', 23:00:10 INFO - 'USER': 'cltbld', 23:00:10 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 23:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:10 INFO - '_': '/tools/buildbot/bin/python'} 23:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:10 INFO - Downloading/unpacking flake8 23:00:10 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:10 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:10 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:10 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:10 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:10 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:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:00:12 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:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:00:12 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:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:12 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:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:13 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:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:00:13 INFO - no previously-included directories found matching 'docs/_build' 23:00:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:00:13 INFO - Running setup.py install for pep8 23:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:00:13 INFO - no previously-included directories found matching 'docs/_build' 23:00:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:00:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:00:13 INFO - Cleaning up... 23:00:13 INFO - Return code: 0 23:00:13 INFO - Running post-action listener: _resource_record_post_action 23:00:13 INFO - Running post-action listener: _start_resource_monitoring 23:00:13 INFO - Starting resource monitoring. 23:00:13 INFO - ##### 23:00:13 INFO - ##### Running install step. 23:00:13 INFO - ##### 23:00:13 INFO - Running pre-action listener: _resource_record_pre_action 23:00:13 INFO - Running main action method: install 23:00:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:00:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:00:13 INFO - Reading from file tmpfile_stdout 23:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 23:00:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:00:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:00:13 INFO - Reading from file tmpfile_stdout 23:00:13 INFO - Output received: 23:00:13 INFO - Usage: mozinstall [options] installer 23:00:13 INFO - Options: 23:00:13 INFO - -h, --help show this help message and exit 23:00:13 INFO - -d DEST, --destination=DEST 23:00:13 INFO - Directory to install application into. [default: 23:00:13 INFO - "/builds/slave/test-pgo"] 23:00:13 INFO - --app=APP Application being installed. [default: firefox] 23:00:13 INFO - mkdir: /builds/slave/test-pgo/build/application 23:00:13 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:13 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:29 INFO - Reading from file tmpfile_stdout 23:00:29 INFO - Output received: 23:00:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:00:29 INFO - Running post-action listener: _resource_record_post_action 23:00:29 INFO - ##### 23:00:29 INFO - ##### Running run-tests step. 23:00:29 INFO - ##### 23:00:29 INFO - Running pre-action listener: _resource_record_pre_action 23:00:29 INFO - Running main action method: run_tests 23:00:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:00:29 INFO - Python 2.7.3 23:00:29 INFO - Return code: 0 23:00:29 INFO - grabbing minidump binary from tooltool 23:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:29 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 0x16de840>, '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 0x164b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:00:29 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:29 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:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:00:29 INFO - Return code: 0 23:00:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:00:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:00:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:00:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:00:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:00:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:00:30 INFO - Return code: 0 23:00:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 23:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:00:30 INFO - Using env: {'DISPLAY': ':0', 23:00:30 INFO - 'HOME': '/home/cltbld', 23:00:30 INFO - 'LANG': 'en_US.UTF-8', 23:00:30 INFO - 'LANGUAGE': 'en_US:en', 23:00:30 INFO - 'LOGNAME': 'cltbld', 23:00:30 INFO - 'MAIL': '/var/mail/cltbld', 23:00:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:00:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:30 INFO - 'MOZ_NO_REMOTE': '1', 23:00:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:30 INFO - 'NO_EM_RESTART': '1', 23:00:30 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:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:00:30 INFO - 'SHELL': '/bin/bash', 23:00:30 INFO - 'SHLVL': '1', 23:00:30 INFO - 'TERM': 'linux', 23:00:30 INFO - 'TMOUT': '86400', 23:00:30 INFO - 'USER': 'cltbld', 23:00:30 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812', 23:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:30 INFO - '_': '/tools/buildbot/bin/python'} 23:00:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DQl6KdI6TbOwEI4hE6HqQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:00:30 INFO - mozversion application_buildid: 20160105203052 23:00:30 INFO - mozversion application_changeset: 1a9729efc3da75a85714f20c1afd471b9e684dfb 23:00:30 INFO - mozversion application_display_name: Nightly 23:00:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:00:30 INFO - mozversion application_name: Firefox 23:00:30 INFO - mozversion application_remotingname: firefox 23:00:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:00:30 INFO - mozversion application_vendor: Mozilla 23:00:30 INFO - mozversion application_version: 46.0a1 23:00:30 INFO - mozversion platform_buildid: 20160105203052 23:00:30 INFO - mozversion platform_changeset: 1a9729efc3da75a85714f20c1afd471b9e684dfb 23:00:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:00:30 INFO - mozversion platform_version: 46.0a1 23:00:30 INFO - using testdate: 1452063630 23:00:30 INFO - actual date: 1452063630 23:00:30 INFO - starting webserver on 'localhost:37855' 23:00:30 INFO - SUITE-START | Running 3 tests 23:00:30 INFO - TEST-START | dromaeo_css 23:00:30 INFO - operating with platform_type : linux_ 23:00:30 INFO - Initialising browser for dromaeo_css test... 23:00:30 INFO - TEST-INFO | started process 3933 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprQiPGc/profile http://localhost:37855/getInfo.html) 23:00:35 INFO - PROCESS | 3933 | __metrics Screen width/height:1600/1200 23:00:35 INFO - PROCESS | 3933 | colorDepth:24 23:00:35 INFO - PROCESS | 3933 | Browser inner width/height: 1024/697 23:00:35 INFO - PROCESS | 3933 | __metrics 23:00:35 INFO - PROCESS | 3933 | 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:36 INFO - TEST-INFO | 3933: exit 0 23:00:36 INFO - Browser initialized. 23:00:36 INFO - Running cycle 1/1 for dromaeo_css test... 23:00:36 INFO - TEST-INFO | started process 4066 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprQiPGc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:48 INFO - PROCESS | 4066 | RSS: Main: 150716416 23:00:48 INFO - PROCESS | 4066 | 23:01:37 INFO - PROCESS | 4066 | 1452063697900 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:46 INFO - PROCESS | 4066 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37855/tests/dromaeo/cssquery-ext.html) 23:03:48 INFO - PROCESS | 4066 | RSS: Main: 157229056 23:03:48 INFO - PROCESS | 4066 | 23:06:50 INFO - PROCESS | 4066 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-ext.html (next: http://localhost:37855/tests/dromaeo/cssquery-jquery.html) 23:06:50 INFO - PROCESS | 4066 | RSS: Main: 154279936 23:06:50 INFO - PROCESS | 4066 | 23:09:52 INFO - PROCESS | 4066 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37855/tests/dromaeo/cssquery-mootools.html) 23:09:53 INFO - PROCESS | 4066 | RSS: Main: 153083904 23:09:53 INFO - PROCESS | 4066 | 23:12:54 INFO - PROCESS | 4066 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37855/tests/dromaeo/cssquery-prototype.html) 23:12:55 INFO - PROCESS | 4066 | RSS: Main: 151306240 23:12:55 INFO - PROCESS | 4066 | 23:15:57 INFO - PROCESS | 4066 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37855/tests/dromaeo/cssquery-yui.html) 23:15:58 INFO - PROCESS | 4066 | RSS: Main: 152489984 23:15:58 INFO - PROCESS | 4066 | 23:19:00 INFO - PROCESS | 4066 | Cycle 1(1): loaded http://localhost:37855/tests/dromaeo/cssquery-yui.html (next: http://localhost:37855/tests/dromaeo/cssquery-dojo.html) 23:19:01 INFO - PROCESS | 4066 | RSS: Main: 155406336 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | __start_tp_report 23:19:01 INFO - PROCESS | 4066 | _x_x_mozilla_page_load 23:19:01 INFO - PROCESS | 4066 | _x_x_mozilla_page_load_details 23:19:01 INFO - PROCESS | 4066 | |i|pagename|runs| 23:19:01 INFO - PROCESS | 4066 | |0;dojo.html;3168.8098714077155;3273.247153154776;3283.720883724883;3295.6210035845884;3319.850606722697;5212.921806172911;5352.197170424433;5364.892702145955;5367.624266301361;5380.192971054344;5264.289320941672;5276.762545685444;5440;5555.583331250152;5557.3331200256025;4914.827981020665;5001.674891132065;5048.823291184809;5065.949340506603;5075.441701412841;4961.826336078238;4989.501049895;5019.623528235379;5053.166227572465;5085.79656813727;4774.928376074362;4862.17343051682;4882.951170488285;4930.827421040264;4986.601071914256;4903.509649035103;4905.828296009622;4909.779059942275;4926.926096108561;4943.431505376891;4900.926486102711;4910.607151427877;4918.483559226302;4919.360483137205;4934.6792458490445;5075.670081444694;5166.61250406221;5225.216217567396;5322.441143679896;5363.436839131874;5797.594168408213;5819.0689489681445;5819.301683797971;5820.010598198316;5824.563157763185;5835.183074369592;5843.065109582489;5843.766249350021;5857.297124345063;5861.413858614147;5234.345706786652;5382.461753824626;5418.214358917974;5538.9169162462595;5580.609357344947;5851.327097383855;5876.9118463223085;5876.970615146983;5899.144624029492;5900.43945825146;5533.3083364579425;5665.631733937281;5671.744771485293;5678.063119585305;5687.914681279784;5674.06377947634;5816.592838501264;5861.531077513789;5877.617954832922;5918.082697181943;5753.424657534297;5767.798127065533;5777.0467872801355;5786.797462088806;5789.942100579025;5596.964561556125;5733.283339582552;5753.108268218432;5770.16332631766;5807.245058142499;4409.977950110229;4462.9776851116185;4472.821087156477;4503.482099558527;4509.458864936229;3975.045988962686;4001.47980762499;4001.579834117434;4003.6997225208224;4052.392141178788;5311.044012077786;5390.218418329398;5390.4879036491475;5428.5385742211565;5507.669539827623;5757.222774925332;5799.9130013049835;5811.506021988093;5822.1266809978;5823.592348535646;5418.674879507243;5445.646033007921;5450.672959622435;5451.536619387317;5455.481729235717;4772.928406073912;4862.222044472867;4899.510048995143;4959;5009.7244651544515;5970.462658360769;6003.849903752353;6008.939910600925;6012.038073908154;6015.248093988252;5797.246357973437;5810.6513609183585;5815.331236907809;5817.941820581909;5822.272215973004;5789.478946894799;5911.113333000085;5914.260717410324;5995.790147344822;6058.848528786815;5719.113537401709;5724.656520608777;5725.255716756795;5725.799597014085;5745.885082298414;5552.472515111058;5762.423757624204;5772.942270577409;5833.416658334133;5835.7373918174635;5582.49757521825;5648.011597970421;5750.108733146369;5757.481826635623;5798.6810725410505;5604.131359639263;5632.633878797865;5633.295838020247;5637.43625637433;5639.971800140973;5368.2484452177505;5508.669479831223;5524.640898341756;5540.75066622011;5546.805861794818;5589.273394458694;5600.439956004367;5668.858278542904;5751.281089863767;5795.971020144872;5559.8888022240135;5607.635503692247;5611.551075913999;5622.072358060874;5645.4072322405555 23:19:01 INFO - PROCESS | 4066 | |1;ext.html;514.2594663684295;549.2228496677202;589.1486801571731;597.808701215611;598.9338976621613;35141.47287790682;35790.463143052875;35874.641253587455;35963.64036359642;36004.81997590015;41459.170816583726;42017.369739453854;42066.15867682652;42071.78964105183;42129;8528.70149544766;8742.082081381459;8773.298136149124;8815.426997245191;8819.073997230294;8584.570771461433;8616.483011019327;8624.611892464824;8661;8688.478691278511;8640.30877529796;8709.129087091304;8712.564371781385;8731.60707768152;8744.169303916118;8660.610272537719;8690.956545217297;8712.520811355373;8755.824883502326;8756.255718263923;8412.621432035574;8539.188777066169;8550.572471376407;8556.486610803371;8568.400211985163;39387.8030609848;39789.40315895264;40033.79983100066;40205.597944020476;40250;2996.4306781711625;3012.969870301291;3037.9848100759577;3199.9040028799172;3697.3714468540143;29278.85360573205;29582.408351832844;29691.554626680616;29997.100086997423;30392.54411183834;3798.981005094957;3951.7431366961055;3993.800309984489;4036.9394459083137;4065.433840723138;270247;271672;271860;271949;272590;56082.439175607724;56381.43618563762;56485.435145648014;56499.71750141223;56731.43268567262;60194.39805601975;60359;60437.395626044054;60560.394396055475;65241.67379163074;15660.373585056697;15820.446284380221;15874.52376428709;15886.841131588537;15918.60203494922;11885.168038237412;11913.16607837443;11949.163558550817;11966.102542309362;12014.459349329301;20064.69902951457;20515.794842051688;20520.589588208153;20568.382948511568;20615.278465253945;7721;7921.881171782428;7953.840923181504;7966.800829979181;8065.596720164086;872.7992561710842;872.8472517309573;903.3405613901889;915.3546749541557;1012.4684540616236;28781.424371512454;29273.268168295537;30578.235544111576;31233.8438307807;31680.207994799854;940.948247846375;967.8790151231096;997.2719914462483;1013.554036224059;1077.53665923652;13541.322933853267;13707.862921370659;13756.518521851687;13903.86096139046;13976.720465590835;293267;294774;296097;297471;297793;47921.28118078232;48562.75718621455;48581.75709121432;48583.75708121437;48590;1323.358171286925;1327.5154568582398;1339.82582264305;1357.2331632627534;1365.3855764905832;26042;26931.41549917026;27134;27331;27548.17355479339;41586.58413415827;41634.58365416307;41749.791251044764;41809.79095104627;42037;297276;298386;298799;299034;299710;31603.20991975219;42545;42856;43527.78236108926;43560.34659480174;41536.79231603823;42472;42919;42965.14069718651;43422.56577434185;36129.096772580895;36511.634883650826;37095.629043710294;40683.59316406798;42329.365059524745;38798.6120138795;38801.223975519766;40190;40288.59711402848;40528.59471405366;33327.83336083304;33430.498542521396;33619.327613448084;33632.83183584066;33779.493307599914;32720.34559308848;32723.509147362332;35265.47101793424;35788;35852.82073589615;23695.407614809767;24403.511929761662;24930.875345623157;25231.24306270815;25265.368365791 23:19:01 INFO - PROCESS | 4066 | |2;jquery.html;354.5461808884627;354.80498114479127;359.7733427940397;362.2158027869662;364.0389372057768;16577.834221657795;17304.56738581536;17357;17901.91049044756;18000.099995000248;11032.44837758113;11910.344931028812;15748;15775.60560985976;15795.447159349425;4677.649176311773;4922.75386230687;4929.950700492985;4964.379452568429;4970.527799859007;5281.445448227938;5309.522143007129;5318.494742999428;5319.654222475546;5353.0899747043095;5027.798888044474;5028.321176641161;5206.7656955436905;5226.372835259775;5300.973495132538;4980.726060066695;5141.485851414847;5142.151544995108;5145.485451454843;5161.30322406476;4926.11329960607;4950.752462376903;4952;4958.578520825734;4964.429090654585;12636.368181590884;14908.925455372762;15419.22903854814;15458.922705386514;19208.903955480273;2010.359709371919;2021.2925476083253;2029.8477614178848;2131.3392848217104;2150.580636775829;11620.6513804586;12726.427310770945;12782.552610658675;13075.21548707071;13224.6693832654;1731.8354756298259;1809.095452273863;1811.5380577952537;1816.2553353125156;1860.6832149413367;56600;57354.42645573532;57449;62342.376576234565;64692.676536617015;9592.280578956606;9644.373115747454;9664.226861851035;9768.658096966572;9792.461414622121;12127.575534856238;12190.512379504898;12199.207051541622;12203.169524571385;12213.572524961584;7670.156282808886;7677.961610191914;7688.884666730003;7707;7708.5760283183845;7701.691932322757;7703.922960770433;7726.150123486412;7756.457048006699;7908.683652653945;4062.532808727034;4157.97921010393;4184.602462766033;4284.8500302489265;4469.843555475608;1511.6372070702953;1682.9410970616213;1716.4335769196136;1788.0791392432907;1833.642439724241;426.25192786659215;426.3625879310451;439.5911802024148;479.3983550643989;804.637912939168;10540.63107791239;10647.680569582924;10649.733756656145;10717.356958582353;10958.945205273923;442.763121729873;443.029764815054;444.32019010913353;456.91318649456497;465.7810828910407;5832.154337621021;5903.321118071391;5998.580099393088;6012.30858451275;6067.969660151671;489356;493945;496906;503635;511106;80522.59738701386;81647;81931.5903420491;82165.58917205376;82677;464.21547584581947;468.8734041808693;471.0649361018376;471.28835458457974;472.67857856657804;9906.603735850485;10044.648437304952;10066.848997265193;10075.546600403146;10115.898841011496;31662.68337316597;31861.522077168396;31979.84010079935;32485.025449235614;32976.1755956103;45345.319820202065;46157;47839.521604783506;48822;49555.50444495653;9063.818723625622;9297.581608827484;9482.95687474391;9531.189848862925;9543.236541076558;15670.608234794221;17434.128293585018;17459.82540174582;17673.20470578801;17874.821251787314;13747.862521374658;13760.449582017007;14265.358058887168;14688.41246350134;14912.478063267734;13870.65323366924;14533.636659083608;14589.343479543233;14778.556643300719;15208.391664333303;14824;14978.325975331354;15156.621084472976;15294.694106118039;15494.380224791334;9003.459792412476;9261.44431334122;9284.95357523208;9286.814263714552;9298;10100;10220.642277520252;13273.800892986807;13540.93229533846;14030.438782448588 23:19:01 INFO - PROCESS | 4066 | |3;mootools.html;1435.0170133458578;1442.5095467541034;1588.9602759931001;1754.0966402302824;1788.2399980008502;7485.476016678835;7554.697812087524;7619.504732192404;7748.225177482256;7768.990031295931;7631.2368763123795;7681.884771728429;7708.498947568418;7776.183500732426;7796.220377962215;2227.1536816009975;2277.9886100569474;2290.209877592228;2297.127091705158;2299.4021554395895;2276.8747718875456;2312.2022902098747;2314.4908120213527;2315.8536524420438;2316.652502124686;2242.2040175737625;2243.6858839762363;2273.2952784636814;2289.278877153691;2304.158981971585;2217.966730499044;2235.5305385868987;2266.8526545774635;2277.772222777717;2278.8063014643776;2247.078697733921;2292.587334279829;2293.655951607272;2293.759155288704;2300.229423143249;7382.7785166444555;7400.407967362652;7444.36722878556;7449.143348514936;7451.031365922396;4701.459332176809;4724.45668748095;4754.858833879878;4759.643026773006;4774.28385742138;2900.985495072532;2957.704229577025;2970.1386597886585;2975.4049190161836;2979.702029797025;923.233716015712;924.3483344242293;926.4487629860222;947.8388673925381;960.3565611040619;10413.791724165474;10498.947505262502;10526.842097368546;10527.21045921559;10545.789084218273;3932.0956180078742;4024.8390064397095;4026.053877338823;4066.9389959150044;4087.6729861611;8569.100244474364;8595.097514760984;8599.914000860037;8605.870911936327;8617.35369847264;4570.702904311275;4579.793909274091;4581.816727330869;4589.632829373642;4607.3319368691355;4205.411242426002;4217.051163488252;4219.409282700424;4234.153169366139;4239.215745087169;3274.476083826576;3339.1985923378215;3339.382214290364;3353.245519758084;3376.898693039213;982.4891056650501;997.8802543694803;1006.2201793610011;1014.761531040205;1018.5467466977273;960.0399600399601;1008.1380419741163;1031.3141760729181;1077.902988731018;1097.868255809308;7187.173475050332;7211.170715367695;7224.096987876515;7229.277072292729;7242.746503872445;598.7934162713943;609.1471939285036;610.531671330451;610.703808652803;743.4609907816789;5450.618456707993;5539.473749993825;5546.112621980464;5562.554995600342;5587.580931430078;9039.276857851357;9104.089591040974;9436.764080898032;9468.715938521855;9581.041895810502;9357.812843743088;9430.19843313326;9437.811243775086;9444.8583271251;9473.478958657202;7202.315780000997;7388.889166662504;7465.738699145504;7477.177510473953;7513.361364284097;7040.260772619006;7074.080369551925;7094.645267736696;7128.108986376703;7154;8158.714444994397;8161.959190204011;8350.498970061815;8373.916260837314;8556.74329770108;8530.488170709777;8558.229759321692;8611.82776344482;8634;8680.565971701515;6463.7737679181;6542.34576542361;6554.279029306867;6572.8356791080605;6577.736890524326;7504.1370242420635;7512.8873066905135;7527.8494430109995;7530.9246907532415;7539.585322807298;6894.8621027578165;6909.861802763816;7072.893906591303;7143;7236.312550307713;6729.226138993882;6851;6854.862902742017;6855.348741869514;6906.998485219716;6771.255161932282;6869.107016087876;6895.586264824126;6907.102076729993;6909.412699920563;6050.606710563799;6151.446369826737;6171.537134714825;6175.722092505938;6195.721192546256;6346.809595712136;6374.90437643445;6376.266729326001;6440.323766004502;6493.642849643315 23:19:01 INFO - PROCESS | 4066 | |4;prototype.html;335.8774047472672;341.3241781273079;343.4676251809695;343.99140021499477;349.5420998491976;6167.599106058103;6224.128621992924;6260.968695156529;6265;6329.33541978092;6092.66490343031;6197.5041996640275;6264.906026409596;6273.843153921154;6281.780137695182;4827.565519103271;4830.347903033081;4832.420109586855;4838.9032219355595;4839.540243676845;4840.806367745286;4843.612510999129;4850.830220942268;4852.708837469745;4857.1742803723455;4733.644976626767;4808.927866082012;4812.061647978646;4819.590334821544;4829.951700483003;4784.282357646381;4797.376341075638;4805.303231031516;4809.735464549449;4817.710937343735;4212.662986961066;4212.662986961066;4222.9577704222875;4232.682548808821;4245.469316335458;5979.880402391927;5992.310884248323;6005.849853753647;6011.909821352683;6017.69911504423;5460.836174914759;5609.1305847593685;5609.747561359749;5625.128105143709;5631.5776316776;6580.605163690194;6582.670866456658;6645.06969024337;6647.501437392215;6655.101561289261;4669.463011753658;4675.859724208279;4681.695689780154;4683.15703173432;4685.2972054191805;6721.798346049626;6877.89683154753;6920.342567456084;6978.337057979484;6985.615791131486;4661.836835710734;4699.95300047002;4707.576318131385;4708.270218116198;4713.6464765142755;4763.618910487153;4765.309030190603;4770.165221086296;4770.809167633256;4771.880702982453;5531.059719847555;5534.335879694462;5537.667739935617;5539.556835453154;5542.778288868481;6524.510661700391;6662.200535935719;6662.86674266512;6665.866682666319;6728.259891411941;1640.5078476457015;1658.4941592814066;1680.0843540270582;1682.5204816627447;1686.1569215392303;1092.6667366453148;1104.4036220441033;1111.822108462642;1112.477135746198;1117.636768050387;6323.652199129;6324.494040476751;6328.968355158195;6330.746770129143;6338.144350512714;6801.2858649841055;6845.418139458102;6853.588784672836;6854;6859.348361905611;6113.663748493786;6251.3123556408755;6265.937340626627;6313.053042043638;6321.841953951096;3715;3732.8133593320226;3736.6823819975607;3740.1958578905665;3741;7094.148702155774;7129.857402851914;7135.4648401370105;7156.964215178891;7161.212266650664;6957.8956315655305;7006.544574602634;7008.894866577006;7032.718691252395;7067.43460523157;7264.091988501437;7307.89038164428;7316.231795661485;7343.926560734431;7348.70605175787;7036.472264580075;7037.437005039687;7040.471964602778;7040.683169257293;7050.224475307609;6788.558743681645;6923.861522769415;6947.513674042971;6947.652617369213;6955.686994085379;7231.566106033655;7240.782776516713;7255.129384473897;7257.927420725725;7274.781756547312;4656.67403281767;4706.035262771192;4711.670183087288;4731.266653668549;4741.5495527924795;6848.657567121524;7009.719611215494;7019;7025.332593403618;7031.578105313698;6790.8641827164165;6802.319768023158;6802.93197068023;6814.352636499525;6818.931810682028;6777.525573209828;6784.050232967487;6785.253622101466;6788.049673045679;6806.081179040964;6534.281229064894;6663.333666633298;6680.498962577729;6680.4989625779235;6682.064510968371;6835.897461537981;6836.418904393182;6841.3842754152365;6844.760433384808;6856.41720453767;6658;6689;6733.764318248838;6735.494837887276;6739.460843132636 23:19:01 INFO - PROCESS | 4066 | |5;yui.html;797.6530209358925;801.6713147609481;803.7789607857839;817.2032268538175;849.5624753252074;12699.428525716341;12856.48574057039;12857.742845143091;12868.806967895489;12885.742285154303;12856.871431285685;12972;13080.73838523229;13097.279649619268;14379.209143497104;826.1119296755982;833.0461621443474;833.7665453672981;837.4682076881163;839.95380254086;824.1593574553951;827.4538804389105;828.0642873552907;830.0495932157676;830.4933990265932;874.9325822496544;875.8423483772918;877.0089798527687;877.6094637886143;879.5162660536711;873.5501216873315;873.9257163141141;874.6545114679698;875.3609864798701;882.4793371910539;646.3310473659786;647.8445173158408;648.3743187823726;649.4544582550633;650.6616559389091;14206.147631142165;14258.500952466718;14281.14313141215;14337.283135843167;14364.138151710826;12216.633500994896;12295.877041229653;12460.75078498425;12540.122191446602;13108.80336794949;9875.211062154687;10556.261061725681;10641.095506881924;10690.893091069067;10932.070773984142;3549.2901419715904;3635.9272814543824;3643.1802844360072;3658.0489072840987;3669.412893936957;41591.584084159076;42561;45911.77044114791;47662.76168619169;47687.76156119232;9981.80036399268;10025.598976041023;10111.3427627204;10442.63450779219;10543.578256869792;18417.079146042644;18437.26250949974;18486.722699159523;18497.075146242903;18511.53721156982;7665.655045522964;7836.294733473901;7997.920020799834;8182.672693092329;8188.344932405394;4308.655307575386;4455.554444555583;4464.598186163261;4476.08240310742;4495.820167193341;3012.969870301269;3047.360054388603;3051.343961048385;3052.4658184817567;3056.69433056697;519.5142541723425;543.4701166362764;549.8515400841831;562.9240052592847;564.7091747749912;605.4006533531772;658.3285049249738;679.7077256779534;681.0873429604354;701.8526109516956;8289.668413263522;8457.281131103802;8495.532745699045;8642.611082501302;8644.351673624504;561.6573889927141;638.4222278837659;683.8852670147628;699.6208313844121;725;3975.363941769303;4184.225918205142;4284.400183974246;4298.376735373416;4434.290513517822;56262.156067659016;57146.714266428404;57208;57280;57299;48151.27773083407;48593.757031215326;49022.26466603004;49318.26022609664;53537.73231133819;44172.779136104116;45661.77169114133;49038.01923961501;49911;49967;8320.16798320163;8616.827663446571;8902.688405905763;8936.374453788432;9033.593488293174;33636.99089027333;34109.65890341065;34412.48381274233;34563.30873382569;35603;42445.575544245396;42591.14817703567;42837;43347;43385.13229735451;11710.386370187782;12006.339651319262;12006.579769708018;12272.325022123869;12416.068794840243;12180.21574843984;12321.50713971467;12389.62831115068;12623.431945562288;12751.808722868978;11025.669229923114;11231.719207019563;11757.588484403004;11769.941150294193;12029.097817663886;11162.720931976766;11241.437928103725;11576.131790115944;11756.529738810694;11776.470058847544;10707.196960227859;10963.397013164353;11074.843784312474;11121.443927803739;11219.49512271966;9332.766680832761;9488.525573721148;9547.713568592953;9552.952235239058;9728.659496917573;7884.207230089438;8393.571689055108;8405.70580029696;9223.169914707709;9233 23:19:01 INFO - PROCESS | 4066 | __end_tp_report 23:19:01 INFO - PROCESS | 4066 | __start_cc_report 23:19:01 INFO - PROCESS | 4066 | _x_x_mozilla_cycle_collect,309 23:19:01 INFO - PROCESS | 4066 | __end_cc_report 23:19:01 INFO - PROCESS | 4066 | __startTimestamp1452064741234__endTimestamp 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | ------- Summary: start ------- 23:19:01 INFO - PROCESS | 4066 | Number of tests: 6 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | [#0] dojo.html Cycles:165 Average:5374.68 Median:5580.61 stddev:588.15 (10.5%) stddev-sans-first:563.92 23:19:01 INFO - PROCESS | 4066 | Values: 3168.8 3273.2 3283.7 3295.6 3319.9 5212.9 5352.2 5364.9 5367.6 5380.2 5264.3 5276.8 5440.0 5555.6 5557.3 4914.8 5001.7 5048.8 5065.9 5075.4 4961.8 4989.5 5019.6 5053.2 5085.8 4774.9 4862.2 4883.0 4930.8 4986.6 4903.5 4905.8 4909.8 4926.9 4943.4 4900.9 4910.6 4918.5 4919.4 4934.7 5075.7 5166.6 5225.2 5322.4 5363.4 5797.6 5819.1 5819.3 5820.0 5824.6 5835.2 5843.1 5843.8 5857.3 5861.4 5234.3 5382.5 5418.2 5538.9 5580.6 5851.3 5876.9 5877.0 5899.1 5900.4 5533.3 5665.6 5671.7 5678.1 5687.9 5674.1 5816.6 5861.5 5877.6 5918.1 5753.4 5767.8 5777.0 5786.8 5789.9 5597.0 5733.3 5753.1 5770.2 5807.2 4410.0 4463.0 4472.8 4503.5 4509.5 3975.0 4001.5 4001.6 4003.7 4052.4 5311.0 5390.2 5390.5 5428.5 5507.7 5757.2 5799.9 5811.5 5822.1 5823.6 5418.7 5445.6 5450.7 5451.5 5455.5 4772.9 4862.2 4899.5 4959.0 5009.7 5970.5 6003.8 6008.9 6012.0 6015.2 5797.2 5810.7 5815.3 5817.9 5822.3 5789.5 5911.1 5914.3 5995.8 6058.8 5719.1 5724.7 5725.3 5725.8 5745.9 5552.5 5762.4 5772.9 5833.4 5835.7 5582.5 5648.0 5750.1 5757.5 5798.7 5604.1 5632.6 5633.3 5637.4 5640.0 5368.2 5508.7 5524.6 5540.8 5546.8 5589.3 5600.4 5668.9 5751.3 5796.0 5559.9 5607.6 5611.6 5622.1 5645.4 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | [#1] ext.html Cycles:180 Average:46045.89 Median:21669.77 stddev:75376.03 (347.8%) stddev-sans-first:75509.96 23:19:01 INFO - PROCESS | 4066 | Values: 514.3 549.2 589.1 597.8 598.9 35141.5 35790.5 35874.6 35963.6 36004.8 41459.2 42017.4 42066.2 42071.8 42129.0 8528.7 8742.1 8773.3 8815.4 8819.1 8584.6 8616.5 8624.6 8661.0 8688.5 8640.3 8709.1 8712.6 8731.6 8744.2 8660.6 8691.0 8712.5 8755.8 8756.3 8412.6 8539.2 8550.6 8556.5 8568.4 39387.8 39789.4 40033.8 40205.6 40250.0 2996.4 3013.0 3038.0 3199.9 3697.4 29278.9 29582.4 29691.6 29997.1 30392.5 3799.0 3951.7 3993.8 4036.9 4065.4 270247.0 271672.0 271860.0 271949.0 272590.0 56082.4 56381.4 56485.4 56499.7 56731.4 60194.4 60359.0 60437.4 60560.4 65241.7 15660.4 15820.4 15874.5 15886.8 15918.6 11885.2 11913.2 11949.2 11966.1 12014.5 20064.7 20515.8 20520.6 20568.4 20615.3 7721.0 7921.9 7953.8 7966.8 8065.6 872.8 872.8 903.3 915.4 1012.5 28781.4 29273.3 30578.2 31233.8 31680.2 940.9 967.9 997.3 1013.6 1077.5 13541.3 13707.9 13756.5 13903.9 13976.7 293267.0 294774.0 296097.0 297471.0 297793.0 47921.3 48562.8 48581.8 48583.8 48590.0 1323.4 1327.5 1339.8 1357.2 1365.4 26042.0 26931.4 27134.0 27331.0 27548.2 41586.6 41634.6 41749.8 41809.8 42037.0 297276.0 298386.0 298799.0 299034.0 299710.0 31603.2 42545.0 42856.0 43527.8 43560.3 41536.8 42472.0 42919.0 42965.1 43422.6 36129.1 36511.6 37095.6 40683.6 42329.4 38798.6 38801.2 40190.0 40288.6 40528.6 33327.8 33430.5 33619.3 33632.8 33779.5 32720.3 32723.5 35265.5 35788.0 35852.8 23695.4 24403.5 24930.9 25231.2 25265.4 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | [#2] jquery.html Cycles:180 Average:27029.43 Median:441.18 stddev:81751.81 (18530.4%) stddev-sans-first:81956.61 23:19:01 INFO - PROCESS | 4066 | Values: 354.5 354.8 359.8 362.2 364.0 16577.8 17304.6 17357.0 17901.9 18000.1 11032.4 11910.3 15748.0 15775.6 15795.4 4677.6 4922.8 4930.0 4964.4 4970.5 5281.4 5309.5 5318.5 5319.7 5353.1 5027.8 5028.3 5206.8 5226.4 5301.0 4980.7 5141.5 5142.2 5145.5 5161.3 4926.1 4950.8 4952.0 4958.6 4964.4 12636.4 14908.9 15419.2 15458.9 19208.9 2010.4 2021.3 2029.8 2131.3 2150.6 11620.7 12726.4 12782.6 13075.2 13224.7 1731.8 1809.1 1811.5 1816.3 1860.7 56600.0 57354.4 57449.0 62342.4 64692.7 9592.3 9644.4 9664.2 9768.7 9792.5 12127.6 12190.5 12199.2 12203.2 12213.6 7670.2 7678.0 7688.9 7707.0 7708.6 7701.7 7703.9 7726.2 7756.5 7908.7 4062.5 4158.0 4184.6 4284.9 4469.8 1511.6 1682.9 1716.4 1788.1 1833.6 426.3 426.4 439.6 479.4 804.6 10540.6 10647.7 10649.7 10717.4 10958.9 442.8 443.0 444.3 456.9 465.8 5832.2 5903.3 5998.6 6012.3 6068.0 489356.0 493945.0 496906.0 503635.0 511106.0 80522.6 81647.0 81931.6 82165.6 82677.0 464.2 468.9 471.1 471.3 472.7 9906.6 10044.6 10066.8 10075.5 10115.9 31662.7 31861.5 31979.8 32485.0 32976.2 45345.3 46157.0 47839.5 48822.0 49555.5 9063.8 9297.6 9483.0 9531.2 9543.2 15670.6 17434.1 17459.8 17673.2 17874.8 13747.9 13760.4 14265.4 14688.4 14912.5 13870.7 14533.6 14589.3 14778.6 15208.4 14824.0 14978.3 15156.6 15294.7 15494.4 9003.5 9261.4 9285.0 9286.8 9298.0 10100.0 10220.6 13273.8 13540.9 14030.4 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | [#3] mootools.html Cycles:180 Average:5352.37 Median:6478.71 stddev:2819.42 (43.5%) stddev-sans-first:2811.96 23:19:01 INFO - PROCESS | 4066 | Values: 1435.0 1442.5 1589.0 1754.1 1788.2 7485.5 7554.7 7619.5 7748.2 7769.0 7631.2 7681.9 7708.5 7776.2 7796.2 2227.2 2278.0 2290.2 2297.1 2299.4 2276.9 2312.2 2314.5 2315.9 2316.7 2242.2 2243.7 2273.3 2289.3 2304.2 2218.0 2235.5 2266.9 2277.8 2278.8 2247.1 2292.6 2293.7 2293.8 2300.2 7382.8 7400.4 7444.4 7449.1 7451.0 4701.5 4724.5 4754.9 4759.6 4774.3 2901.0 2957.7 2970.1 2975.4 2979.7 923.2 924.3 926.4 947.8 960.4 10413.8 10498.9 10526.8 10527.2 10545.8 3932.1 4024.8 4026.1 4066.9 4087.7 8569.1 8595.1 8599.9 8605.9 8617.4 4570.7 4579.8 4581.8 4589.6 4607.3 4205.4 4217.1 4219.4 4234.2 4239.2 3274.5 3339.2 3339.4 3353.2 3376.9 982.5 997.9 1006.2 1014.8 1018.5 960.0 1008.1 1031.3 1077.9 1097.9 7187.2 7211.2 7224.1 7229.3 7242.7 598.8 609.1 610.5 610.7 743.5 5450.6 5539.5 5546.1 5562.6 5587.6 9039.3 9104.1 9436.8 9468.7 9581.0 9357.8 9430.2 9437.8 9444.9 9473.5 7202.3 7388.9 7465.7 7477.2 7513.4 7040.3 7074.1 7094.6 7128.1 7154.0 8158.7 8162.0 8350.5 8373.9 8556.7 8530.5 8558.2 8611.8 8634.0 8680.6 6463.8 6542.3 6554.3 6572.8 6577.7 7504.1 7512.9 7527.8 7530.9 7539.6 6894.9 6909.9 7072.9 7143.0 7236.3 6729.2 6851.0 6854.9 6855.3 6907.0 6771.3 6869.1 6895.6 6907.1 6909.4 6050.6 6151.4 6171.5 6175.7 6195.7 6346.8 6374.9 6376.3 6440.3 6493.6 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | [#4] prototype.html Cycles:180 Average:5607.38 Median:6277.81 stddev:1704.96 (27.2%) stddev-sans-first:1663.20 23:19:01 INFO - PROCESS | 4066 | Values: 335.9 341.3 343.5 344.0 349.5 6167.6 6224.1 6261.0 6265.0 6329.3 6092.7 6197.5 6264.9 6273.8 6281.8 4827.6 4830.3 4832.4 4838.9 4839.5 4840.8 4843.6 4850.8 4852.7 4857.2 4733.6 4808.9 4812.1 4819.6 4830.0 4784.3 4797.4 4805.3 4809.7 4817.7 4212.7 4212.7 4223.0 4232.7 4245.5 5979.9 5992.3 6005.8 6011.9 6017.7 5460.8 5609.1 5609.7 5625.1 5631.6 6580.6 6582.7 6645.1 6647.5 6655.1 4669.5 4675.9 4681.7 4683.2 4685.3 6721.8 6877.9 6920.3 6978.3 6985.6 4661.8 4700.0 4707.6 4708.3 4713.6 4763.6 4765.3 4770.2 4770.8 4771.9 5531.1 5534.3 5537.7 5539.6 5542.8 6524.5 6662.2 6662.9 6665.9 6728.3 1640.5 1658.5 1680.1 1682.5 1686.2 1092.7 1104.4 1111.8 1112.5 1117.6 6323.7 6324.5 6329.0 6330.7 6338.1 6801.3 6845.4 6853.6 6854.0 6859.3 6113.7 6251.3 6265.9 6313.1 6321.8 3715.0 3732.8 3736.7 3740.2 3741.0 7094.1 7129.9 7135.5 7157.0 7161.2 6957.9 7006.5 7008.9 7032.7 7067.4 7264.1 7307.9 7316.2 7343.9 7348.7 7036.5 7037.4 7040.5 7040.7 7050.2 6788.6 6923.9 6947.5 6947.7 6955.7 7231.6 7240.8 7255.1 7257.9 7274.8 4656.7 4706.0 4711.7 4731.3 4741.5 6848.7 7009.7 7019.0 7025.3 7031.6 6790.9 6802.3 6802.9 6814.4 6818.9 6777.5 6784.1 6785.3 6788.0 6806.1 6534.3 6663.3 6680.5 6680.5 6682.1 6835.9 6836.4 6841.4 6844.8 6856.4 6658.0 6689.0 6733.8 6735.5 6739.5 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - PROCESS | 4066 | [#5] yui.html Cycles:180 Average:13701.66 Median:25078.80 stddev:15605.74 (62.2%) stddev-sans-first:15619.43 23:19:01 INFO - PROCESS | 4066 | Values: 797.7 801.7 803.8 817.2 849.6 12699.4 12856.5 12857.7 12868.8 12885.7 12856.9 12972.0 13080.7 13097.3 14379.2 826.1 833.0 833.8 837.5 840.0 824.2 827.5 828.1 830.0 830.5 874.9 875.8 877.0 877.6 879.5 873.6 873.9 874.7 875.4 882.5 646.3 647.8 648.4 649.5 650.7 14206.1 14258.5 14281.1 14337.3 14364.1 12216.6 12295.9 12460.8 12540.1 13108.8 9875.2 10556.3 10641.1 10690.9 10932.1 3549.3 3635.9 3643.2 3658.0 3669.4 41591.6 42561.0 45911.8 47662.8 47687.8 9981.8 10025.6 10111.3 10442.6 10543.6 18417.1 18437.3 18486.7 18497.1 18511.5 7665.7 7836.3 7997.9 8182.7 8188.3 4308.7 4455.6 4464.6 4476.1 4495.8 3013.0 3047.4 3051.3 3052.5 3056.7 519.5 543.5 549.9 562.9 564.7 605.4 658.3 679.7 681.1 701.9 8289.7 8457.3 8495.5 8642.6 8644.4 561.7 638.4 683.9 699.6 725.0 3975.4 4184.2 4284.4 4298.4 4434.3 56262.2 57146.7 57208.0 57280.0 57299.0 48151.3 48593.8 49022.3 49318.3 53537.7 44172.8 45661.8 49038.0 49911.0 49967.0 8320.2 8616.8 8902.7 8936.4 9033.6 33637.0 34109.7 34412.5 34563.3 35603.0 42445.6 42591.1 42837.0 43347.0 43385.1 11710.4 12006.3 12006.6 12272.3 12416.1 12180.2 12321.5 12389.6 12623.4 12751.8 11025.7 11231.7 11757.6 11769.9 12029.1 11162.7 11241.4 11576.1 11756.5 11776.5 10707.2 10963.4 11074.8 11121.4 11219.5 9332.8 9488.5 9547.7 9553.0 9728.7 7884.2 8393.6 8405.7 9223.2 9233.0 23:19:01 INFO - PROCESS | 4066 | -------- Summary: end -------- 23:19:01 INFO - PROCESS | 4066 | 23:19:01 INFO - TEST-INFO | 4066: exit 0 23:19:01 INFO - TEST-OK | dromaeo_css | took 1111232ms 23:19:01 INFO - TEST-START | kraken 23:19:01 INFO - operating with platform_type : linux_ 23:19:01 INFO - Initialising browser for kraken test... 23:19:01 INFO - TEST-INFO | started process 4312 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptO_MFA/profile http://localhost:37855/getInfo.html) 23:19:06 INFO - PROCESS | 4312 | __metrics Screen width/height:1600/1200 23:19:06 INFO - PROCESS | 4312 | colorDepth:24 23:19:06 INFO - PROCESS | 4312 | Browser inner width/height: 1024/697 23:19:06 INFO - PROCESS | 4312 | __metrics 23:19:06 INFO - PROCESS | 4312 | 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:07 INFO - TEST-INFO | 4312: exit 0 23:19:07 INFO - Browser initialized. 23:19:07 INFO - Running cycle 1/1 for kraken test... 23:19:07 INFO - TEST-INFO | started process 4435 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptO_MFA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:19:19 INFO - PROCESS | 4435 | RSS: Main: 150667264 23:19:19 INFO - PROCESS | 4435 | 23:19:21 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-beat-detection) 23:19:22 INFO - PROCESS | 4435 | RSS: Main: 151203840 23:19:22 INFO - PROCESS | 4435 | 23:19:24 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-dft) 23:19:25 INFO - PROCESS | 4435 | RSS: Main: 151175168 23:19:25 INFO - PROCESS | 4435 | 23:19:28 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-fft) 23:19:28 INFO - PROCESS | 4435 | RSS: Main: 146923520 23:19:28 INFO - PROCESS | 4435 | 23:19:31 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37855/tests/kraken/driver.html?testName=audio-oscillator) 23:19:31 INFO - PROCESS | 4435 | RSS: Main: 146554880 23:19:31 INFO - PROCESS | 4435 | 23:19:34 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37855/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:19:34 INFO - PROCESS | 4435 | RSS: Main: 146321408 23:19:34 INFO - PROCESS | 4435 | 23:19:37 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37855/tests/kraken/driver.html?testName=imaging-darkroom) 23:19:38 INFO - PROCESS | 4435 | RSS: Main: 147726336 23:19:38 INFO - PROCESS | 4435 | 23:19:41 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37855/tests/kraken/driver.html?testName=imaging-desaturate) 23:19:42 INFO - PROCESS | 4435 | RSS: Main: 149315584 23:19:42 INFO - PROCESS | 4435 | 23:19:44 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37855/tests/kraken/driver.html?testName=json-parse-financial) 23:19:45 INFO - PROCESS | 4435 | RSS: Main: 148250624 23:19:45 INFO - PROCESS | 4435 | 23:19:47 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37855/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:19:47 INFO - PROCESS | 4435 | RSS: Main: 148492288 23:19:47 INFO - PROCESS | 4435 | 23:19:49 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:19:50 INFO - PROCESS | 4435 | RSS: Main: 148512768 23:19:50 INFO - PROCESS | 4435 | 23:19:52 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:19:52 INFO - PROCESS | 4435 | RSS: Main: 148938752 23:19:52 INFO - PROCESS | 4435 | 23:19:55 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:19:55 INFO - PROCESS | 4435 | RSS: Main: 148525056 23:19:55 INFO - PROCESS | 4435 | 23:19:58 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:19:59 INFO - PROCESS | 4435 | RSS: Main: 148611072 23:19:59 INFO - PROCESS | 4435 | 23:20:00 INFO - PROCESS | 4435 | Cycle 1(1): loaded http://localhost:37855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37855/tests/kraken/driver.html?testName=ai-astar) 23:20:01 INFO - PROCESS | 4435 | RSS: Main: 149909504 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | __start_tp_report 23:20:01 INFO - PROCESS | 4435 | _x_x_mozilla_page_load 23:20:01 INFO - PROCESS | 4435 | _x_x_mozilla_page_load_details 23:20:01 INFO - PROCESS | 4435 | |i|pagename|runs| 23:20:01 INFO - PROCESS | 4435 | |0;ai-astar;112;106;112;109;112;121;111;111;111;111 23:20:01 INFO - PROCESS | 4435 | |1;audio-beat-detection;152;126;148;169;127;154;149;128;161;134 23:20:01 INFO - PROCESS | 4435 | |2;audio-dft;164;163;163;163;163;164;161;164;173;161 23:20:01 INFO - PROCESS | 4435 | |3;audio-fft;74;72;72;75;72;70;131;73;74;73 23:20:01 INFO - PROCESS | 4435 | |4;audio-oscillator;96;97;145;96;98;96;140;96;96;135 23:20:01 INFO - PROCESS | 4435 | |5;imaging-gaussian-blur;110;110;111;110;109;110;110;110;109;109 23:20:01 INFO - PROCESS | 4435 | |6;imaging-darkroom;146;146;148;146;145;146;146;146;146;146 23:20:01 INFO - PROCESS | 4435 | |7;imaging-desaturate;97;96;96;96;95;97;96;97;97;96 23:20:01 INFO - PROCESS | 4435 | |8;json-parse-financial;60;57;62;58;59;60;61;57;65;58 23:20:01 INFO - PROCESS | 4435 | |9;json-stringify-tinderbox;68;67;67;68;67;69;67;67;67;68 23:20:01 INFO - PROCESS | 4435 | |10;stanford-crypto-aes;85;94;88;87;87;87;99;87;88;86 23:20:01 INFO - PROCESS | 4435 | |11;stanford-crypto-ccm;127;126;122;121;120;128;125;119;122;127 23:20:01 INFO - PROCESS | 4435 | |12;stanford-crypto-pbkdf2;153;153;160;153;148;141;162;150;150;152 23:20:01 INFO - PROCESS | 4435 | |13;stanford-crypto-sha256-iterative;69;71;68;70;68;68;68;68;72;70 23:20:01 INFO - PROCESS | 4435 | __end_tp_report 23:20:01 INFO - PROCESS | 4435 | __start_cc_report 23:20:01 INFO - PROCESS | 4435 | _x_x_mozilla_cycle_collect,746 23:20:01 INFO - PROCESS | 4435 | __end_cc_report 23:20:01 INFO - PROCESS | 4435 | __startTimestamp1452064801062__endTimestamp 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | ------- Summary: start ------- 23:20:01 INFO - PROCESS | 4435 | Number of tests: 14 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:3.78 (3.4%) stddev-sans-first:4.00 23:20:01 INFO - PROCESS | 4435 | Values: 112.0 106.0 112.0 109.0 112.0 121.0 111.0 111.0 111.0 111.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:150.50 stddev:15.21 (10.1%) stddev-sans-first:15.91 23:20:01 INFO - PROCESS | 4435 | Values: 152.0 126.0 148.0 169.0 127.0 154.0 149.0 128.0 161.0 134.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.38 (2.1%) stddev-sans-first:3.59 23:20:01 INFO - PROCESS | 4435 | Values: 164.0 163.0 163.0 163.0 163.0 164.0 161.0 164.0 173.0 161.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#3] audio-fft Cycles:10 Average:78.60 Median:73.00 stddev:18.46 (25.3%) stddev-sans-first:19.51 23:20:01 INFO - PROCESS | 4435 | Values: 74.0 72.0 72.0 75.0 72.0 70.0 131.0 73.0 74.0 73.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:21.19 (22.1%) stddev-sans-first:21.90 23:20:01 INFO - PROCESS | 4435 | Values: 96.0 97.0 145.0 96.0 98.0 96.0 140.0 96.0 96.0 135.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 23:20:01 INFO - PROCESS | 4435 | Values: 110.0 110.0 111.0 110.0 109.0 110.0 110.0 110.0 109.0 109.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:20:01 INFO - PROCESS | 4435 | Values: 146.0 146.0 148.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 23:20:01 INFO - PROCESS | 4435 | Values: 97.0 96.0 96.0 96.0 95.0 97.0 96.0 97.0 97.0 96.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:2.50 (4.2%) stddev-sans-first:2.65 23:20:01 INFO - PROCESS | 4435 | Values: 60.0 57.0 62.0 58.0 59.0 60.0 61.0 57.0 65.0 58.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 23:20:01 INFO - PROCESS | 4435 | Values: 68.0 67.0 67.0 68.0 67.0 69.0 67.0 67.0 67.0 68.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:87.50 stddev:4.32 (4.9%) stddev-sans-first:4.35 23:20:01 INFO - PROCESS | 4435 | Values: 85.0 94.0 88.0 87.0 87.0 87.0 99.0 87.0 88.0 86.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:125.50 stddev:3.27 (2.6%) stddev-sans-first:3.24 23:20:01 INFO - PROCESS | 4435 | Values: 127.0 126.0 122.0 121.0 120.0 128.0 125.0 119.0 122.0 127.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:153.00 stddev:5.88 (3.8%) stddev-sans-first:6.23 23:20:01 INFO - PROCESS | 4435 | Values: 153.0 153.0 160.0 153.0 148.0 141.0 162.0 150.0 150.0 152.0 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - PROCESS | 4435 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.48 (2.1%) stddev-sans-first:1.56 23:20:01 INFO - PROCESS | 4435 | Values: 69.0 71.0 68.0 70.0 68.0 68.0 68.0 68.0 72.0 70.0 23:20:01 INFO - PROCESS | 4435 | -------- Summary: end -------- 23:20:01 INFO - PROCESS | 4435 | 23:20:01 INFO - TEST-INFO | 4435: exit 0 23:20:01 INFO - TEST-OK | kraken | took 60005ms 23:20:01 INFO - TEST-START | v8_7 23:20:01 INFO - operating with platform_type : linux_ 23:20:01 INFO - Initialising browser for v8_7 test... 23:20:01 INFO - TEST-INFO | started process 4721 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptknDds/profile http://localhost:37855/getInfo.html) 23:20:06 INFO - PROCESS | 4721 | __metrics Screen width/height:1600/1200 23:20:06 INFO - PROCESS | 4721 | colorDepth:24 23:20:06 INFO - PROCESS | 4721 | Browser inner width/height: 1024/697 23:20:06 INFO - PROCESS | 4721 | __metrics 23:20:06 INFO - PROCESS | 4721 | 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:20:07 INFO - TEST-INFO | 4721: exit 0 23:20:07 INFO - Browser initialized. 23:20:07 INFO - Running cycle 1/1 for v8_7 test... 23:20:07 INFO - TEST-INFO | started process 4841 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptknDds/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:19 INFO - PROCESS | 4841 | RSS: Main: 151146496 23:20:19 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | Cycle 1(1): loaded http://localhost:37855/tests/v8_7/run.html (next: http://localhost:37855/tests/v8_7/run.html) 23:20:40 INFO - PROCESS | 4841 | RSS: Main: 147120128 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | __start_tp_report 23:20:40 INFO - PROCESS | 4841 | _x_x_mozilla_page_load 23:20:40 INFO - PROCESS | 4841 | _x_x_mozilla_page_load_details 23:20:40 INFO - PROCESS | 4841 | |i|pagename|runs| 23:20:40 INFO - PROCESS | 4841 | |0;Richards;167.2800267648043 23:20:40 INFO - PROCESS | 4841 | |1;DeltaBlue;190.94901661256444 23:20:40 INFO - PROCESS | 4841 | |2;Encrypt;280.42624789680315 23:20:40 INFO - PROCESS | 4841 | |3;Decrypt;5229.166666666667 23:20:40 INFO - PROCESS | 4841 | |4;RayTrace;1055.9662090813094 23:20:40 INFO - PROCESS | 4841 | |5;Earley;732.0644216691069 23:20:40 INFO - PROCESS | 4841 | |6;Boyer;12256.09756097561 23:20:40 INFO - PROCESS | 4841 | |7;RegExp;25275 23:20:40 INFO - PROCESS | 4841 | |8;Splay;557.1030640668523 23:20:40 INFO - PROCESS | 4841 | |9;NavierStokes;4830.917874396136 23:20:40 INFO - PROCESS | 4841 | __end_tp_report 23:20:40 INFO - PROCESS | 4841 | __startTimestamp1452064840884__endTimestamp 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | ------- Summary: start ------- 23:20:40 INFO - PROCESS | 4841 | Number of tests: 10 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#0] Richards Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 167.3 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 190.9 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 280.4 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 5229.2 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 1056.0 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#5] Earley Cycles:1 Average:732.06 Median:732.06 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 732.1 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 12256.1 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#7] RegExp Cycles:1 Average:25275.00 Median:25275.00 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 25275.0 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#8] Splay Cycles:1 Average:557.10 Median:557.10 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 557.1 23:20:40 INFO - PROCESS | 4841 | 23:20:40 INFO - PROCESS | 4841 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:20:40 INFO - PROCESS | 4841 | Values: 4830.9 23:20:40 INFO - PROCESS | 4841 | -------- Summary: end -------- 23:20:40 INFO - PROCESS | 4841 | 23:20:41 INFO - TEST-INFO | 4841: exit 0 23:20:41 INFO - TEST-OK | v8_7 | took 39749ms 23:20:41 INFO - SUITE-END | took 1210s 23:20:41 INFO - Completed test suite (00:20:11) 23:20:41 INFO - Working with test: dromaeo_css 23:20:41 INFO - Generating results file: dromaeo_css 23:20:41 INFO - Working with test: kraken 23:20:41 INFO - Generating results file: kraken 23:20:41 INFO - javascript benchmark 23:20:41 INFO - Working with test: v8_7 23:20:41 INFO - Generating results file: v8_7 23:20:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:20:42 INFO - process_Request line: dromaeo_css 6889.84 graph.html#tests=[[72,64,43]] 23:20:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:42 INFO - process_Request line: kraken 1521.70 graph.html#tests=[[232,64,43]] 23:20:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:42 INFO - process_Request line: v8_7 21452.43 graph.html#tests=[[230,64,43]] 23:20:42 INFO - RETURN: dromaeo_css: 6889.84 23:20:42 INFO - RETURN: kraken: 1521.70 23:20:42 INFO - RETURN: v8_7: 21452.43 23:20:42 INFO - javascript benchmark 23:20:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3168.8098714077155, 3273.247153154776, 3283.720883724883, 3295.6210035845884, 3319.850606722697, 5212.921806172911, 5352.197170424433, 5364.892702145955, 5367.624266301361, 5380.192971054344, 5264.289320941672, 5276.762545685444, 5440.0, 5555.583331250152, 5557.3331200256025, 4914.827981020665, 5001.674891132065, 5048.823291184809, 5065.949340506603, 5075.441701412841, 4961.826336078238, 4989.501049895, 5019.623528235379, 5053.166227572465, 5085.79656813727, 4774.928376074362, 4862.17343051682, 4882.951170488285, 4930.827421040264, 4986.601071914256, 4903.509649035103, 4905.828296009622, 4909.779059942275, 4926.926096108561, 4943.431505376891, 4900.926486102711, 4910.607151427877, 4918.483559226302, 4919.360483137205, 4934.6792458490445, 5075.670081444694, 5166.61250406221, 5225.216217567396, 5322.441143679896, 5363.436839131874, 5797.594168408213, 5819.0689489681445, 5819.301683797971, 5820.010598198316, 5824.563157763185, 5835.183074369592, 5843.065109582489, 5843.766249350021, 5857.297124345063, 5861.413858614147, 5234.345706786652, 5382.461753824626, 5418.214358917974, 5538.9169162462595, 5580.609357344947, 5851.327097383855, 5876.9118463223085, 5876.970615146983, 5899.144624029492, 5900.43945825146, 5533.3083364579425, 5665.631733937281, 5671.744771485293, 5678.063119585305, 5687.914681279784, 5674.06377947634, 5816.592838501264, 5861.531077513789, 5877.617954832922, 5918.082697181943, 5753.424657534297, 5767.798127065533, 5777.0467872801355, 5786.797462088806, 5789.942100579025, 5596.964561556125, 5733.283339582552, 5753.108268218432, 5770.16332631766, 5807.245058142499, 4409.977950110229, 4462.9776851116185, 4472.821087156477, 4503.482099558527, 4509.458864936229, 3975.045988962686, 4001.47980762499, 4001.579834117434, 4003.6997225208224, 4052.392141178788, 5311.044012077786, 5390.218418329398, 5390.4879036491475, 5428.5385742211565, 5507.669539827623, 5757.222774925332, 5799.9130013049835, 5811.506021988093, 5822.1266809978, 5823.592348535646, 5418.674879507243, 5445.646033007921, 5450.672959622435, 5451.536619387317, 5455.481729235717, 4772.928406073912, 4862.222044472867, 4899.510048995143, 4959.0, 5009.7244651544515, 5970.462658360769, 6003.849903752353, 6008.939910600925, 6012.038073908154, 6015.248093988252, 5797.246357973437, 5810.6513609183585, 5815.331236907809, 5817.941820581909, 5822.272215973004, 5789.478946894799, 5911.113333000085, 5914.260717410324, 5995.790147344822, 6058.848528786815, 5719.113537401709, 5724.656520608777, 5725.255716756795, 5725.799597014085, 5745.885082298414, 5552.472515111058, 5762.423757624204, 5772.942270577409, 5833.416658334133, 5835.7373918174635, 5582.49757521825, 5648.011597970421, 5750.108733146369, 5757.481826635623, 5798.6810725410505, 5604.131359639263, 5632.633878797865, 5633.295838020247, 5637.43625637433, 5639.971800140973, 5368.2484452177505, 5508.669479831223, 5524.640898341756, 5540.75066622011, 5546.805861794818, 5589.273394458694, 5600.439956004367, 5668.858278542904, 5751.281089863767, 5795.971020144872, 5559.8888022240135, 5607.635503692247, 5611.551075913999, 5622.072358060874, 5645.4072322405555], "unit": "score", "name": "dojo.html", "value": 5337.356987657552}, {"lowerIsBetter": false, "replicates": [514.2594663684295, 549.2228496677202, 589.1486801571731, 597.808701215611, 598.9338976621613, 35141.47287790682, 35790.463143052875, 35874.641253587455, 35963.64036359642, 36004.81997590015, 41459.170816583726, 42017.369739453854, 42066.15867682652, 42071.78964105183, 42129.0, 8528.70149544766, 8742.082081381459, 8773.298136149124, 8815.426997245191, 8819.073997230294, 8584.570771461433, 8616.483011019327, 8624.611892464824, 8661.0, 8688.478691278511, 8640.30877529796, 8709.129087091304, 8712.564371781385, 8731.60707768152, 8744.169303916118, 8660.610272537719, 8690.956545217297, 8712.520811355373, 8755.824883502326, 8756.255718263923, 8412.621432035574, 8539.188777066169, 8550.572471376407, 8556.486610803371, 8568.400211985163, 39387.8030609848, 39789.40315895264, 40033.79983100066, 40205.597944020476, 40250.0, 2996.4306781711625, 3012.969870301291, 3037.9848100759577, 3199.9040028799172, 3697.3714468540143, 29278.85360573205, 29582.408351832844, 29691.554626680616, 29997.100086997423, 30392.54411183834, 3798.981005094957, 3951.7431366961055, 3993.800309984489, 4036.9394459083137, 4065.433840723138, 270247.0, 271672.0, 271860.0, 271949.0, 272590.0, 56082.439175607724, 56381.43618563762, 56485.435145648014, 56499.71750141223, 56731.43268567262, 60194.39805601975, 60359.0, 60437.395626044054, 60560.394396055475, 65241.67379163074, 15660.373585056697, 15820.446284380221, 15874.52376428709, 15886.841131588537, 15918.60203494922, 11885.168038237412, 11913.16607837443, 11949.163558550817, 11966.102542309362, 12014.459349329301, 20064.69902951457, 20515.794842051688, 20520.589588208153, 20568.382948511568, 20615.278465253945, 7721.0, 7921.881171782428, 7953.840923181504, 7966.800829979181, 8065.596720164086, 872.7992561710842, 872.8472517309573, 903.3405613901889, 915.3546749541557, 1012.4684540616236, 28781.424371512454, 29273.268168295537, 30578.235544111576, 31233.8438307807, 31680.207994799854, 940.948247846375, 967.8790151231096, 997.2719914462483, 1013.554036224059, 1077.53665923652, 13541.322933853267, 13707.862921370659, 13756.518521851687, 13903.86096139046, 13976.720465590835, 293267.0, 294774.0, 296097.0, 297471.0, 297793.0, 47921.28118078232, 48562.75718621455, 48581.75709121432, 48583.75708121437, 48590.0, 1323.358171286925, 1327.5154568582398, 1339.82582264305, 1357.2331632627534, 1365.3855764905832, 26042.0, 26931.41549917026, 27134.0, 27331.0, 27548.17355479339, 41586.58413415827, 41634.58365416307, 41749.791251044764, 41809.79095104627, 42037.0, 297276.0, 298386.0, 298799.0, 299034.0, 299710.0, 31603.20991975219, 42545.0, 42856.0, 43527.78236108926, 43560.34659480174, 41536.79231603823, 42472.0, 42919.0, 42965.14069718651, 43422.56577434185, 36129.096772580895, 36511.634883650826, 37095.629043710294, 40683.59316406798, 42329.365059524745, 38798.6120138795, 38801.223975519766, 40190.0, 40288.59711402848, 40528.59471405366, 33327.83336083304, 33430.498542521396, 33619.327613448084, 33632.83183584066, 33779.493307599914, 32720.34559308848, 32723.509147362332, 35265.47101793424, 35788.0, 35852.82073589615, 23695.407614809767, 24403.511929761662, 24930.875345623157, 25231.24306270815, 25265.368365791], "unit": "score", "name": "ext.html", "value": 18402.837333551284}, {"lowerIsBetter": false, "replicates": [354.5461808884627, 354.80498114479127, 359.7733427940397, 362.2158027869662, 364.0389372057768, 16577.834221657795, 17304.56738581536, 17357.0, 17901.91049044756, 18000.099995000248, 11032.44837758113, 11910.344931028812, 15748.0, 15775.60560985976, 15795.447159349425, 4677.649176311773, 4922.75386230687, 4929.950700492985, 4964.379452568429, 4970.527799859007, 5281.445448227938, 5309.522143007129, 5318.494742999428, 5319.654222475546, 5353.0899747043095, 5027.798888044474, 5028.321176641161, 5206.7656955436905, 5226.372835259775, 5300.973495132538, 4980.726060066695, 5141.485851414847, 5142.151544995108, 5145.485451454843, 5161.30322406476, 4926.11329960607, 4950.752462376903, 4952.0, 4958.578520825734, 4964.429090654585, 12636.368181590884, 14908.925455372762, 15419.22903854814, 15458.922705386514, 19208.903955480273, 2010.359709371919, 2021.2925476083253, 2029.8477614178848, 2131.3392848217104, 2150.580636775829, 11620.6513804586, 12726.427310770945, 12782.552610658675, 13075.21548707071, 13224.6693832654, 1731.8354756298259, 1809.095452273863, 1811.5380577952537, 1816.2553353125156, 1860.6832149413367, 56600.0, 57354.42645573532, 57449.0, 62342.376576234565, 64692.676536617015, 9592.280578956606, 9644.373115747454, 9664.226861851035, 9768.658096966572, 9792.461414622121, 12127.575534856238, 12190.512379504898, 12199.207051541622, 12203.169524571385, 12213.572524961584, 7670.156282808886, 7677.961610191914, 7688.884666730003, 7707.0, 7708.5760283183845, 7701.691932322757, 7703.922960770433, 7726.150123486412, 7756.457048006699, 7908.683652653945, 4062.532808727034, 4157.97921010393, 4184.602462766033, 4284.8500302489265, 4469.843555475608, 1511.6372070702953, 1682.9410970616213, 1716.4335769196136, 1788.0791392432907, 1833.642439724241, 426.25192786659215, 426.3625879310451, 439.5911802024148, 479.3983550643989, 804.637912939168, 10540.63107791239, 10647.680569582924, 10649.733756656145, 10717.356958582353, 10958.945205273923, 442.763121729873, 443.029764815054, 444.32019010913353, 456.91318649456497, 465.7810828910407, 5832.154337621021, 5903.321118071391, 5998.580099393088, 6012.30858451275, 6067.969660151671, 489356.0, 493945.0, 496906.0, 503635.0, 511106.0, 80522.59738701386, 81647.0, 81931.5903420491, 82165.58917205376, 82677.0, 464.21547584581947, 468.8734041808693, 471.0649361018376, 471.28835458457974, 472.67857856657804, 9906.603735850485, 10044.648437304952, 10066.848997265193, 10075.546600403146, 10115.898841011496, 31662.68337316597, 31861.522077168396, 31979.84010079935, 32485.025449235614, 32976.1755956103, 45345.319820202065, 46157.0, 47839.521604783506, 48822.0, 49555.50444495653, 9063.818723625622, 9297.581608827484, 9482.95687474391, 9531.189848862925, 9543.236541076558, 15670.608234794221, 17434.128293585018, 17459.82540174582, 17673.20470578801, 17874.821251787314, 13747.862521374658, 13760.449582017007, 14265.358058887168, 14688.41246350134, 14912.478063267734, 13870.65323366924, 14533.636659083608, 14589.343479543233, 14778.556643300719, 15208.391664333303, 14824.0, 14978.325975331354, 15156.621084472976, 15294.694106118039, 15494.380224791334, 9003.459792412476, 9261.44431334122, 9284.95357523208, 9286.814263714552, 9298.0, 10100.0, 10220.642277520252, 13273.800892986807, 13540.93229533846, 14030.438782448588], "unit": "score", "name": "jquery.html", "value": 7856.8098590447}, {"lowerIsBetter": false, "replicates": [1435.0170133458578, 1442.5095467541034, 1588.9602759931001, 1754.0966402302824, 1788.2399980008502, 7485.476016678835, 7554.697812087524, 7619.504732192404, 7748.225177482256, 7768.990031295931, 7631.2368763123795, 7681.884771728429, 7708.498947568418, 7776.183500732426, 7796.220377962215, 2227.1536816009975, 2277.9886100569474, 2290.209877592228, 2297.127091705158, 2299.4021554395895, 2276.8747718875456, 2312.2022902098747, 2314.4908120213527, 2315.8536524420438, 2316.652502124686, 2242.2040175737625, 2243.6858839762363, 2273.2952784636814, 2289.278877153691, 2304.158981971585, 2217.966730499044, 2235.5305385868987, 2266.8526545774635, 2277.772222777717, 2278.8063014643776, 2247.078697733921, 2292.587334279829, 2293.655951607272, 2293.759155288704, 2300.229423143249, 7382.7785166444555, 7400.407967362652, 7444.36722878556, 7449.143348514936, 7451.031365922396, 4701.459332176809, 4724.45668748095, 4754.858833879878, 4759.643026773006, 4774.28385742138, 2900.985495072532, 2957.704229577025, 2970.1386597886585, 2975.4049190161836, 2979.702029797025, 923.233716015712, 924.3483344242293, 926.4487629860222, 947.8388673925381, 960.3565611040619, 10413.791724165474, 10498.947505262502, 10526.842097368546, 10527.21045921559, 10545.789084218273, 3932.0956180078742, 4024.8390064397095, 4026.053877338823, 4066.9389959150044, 4087.6729861611, 8569.100244474364, 8595.097514760984, 8599.914000860037, 8605.870911936327, 8617.35369847264, 4570.702904311275, 4579.793909274091, 4581.816727330869, 4589.632829373642, 4607.3319368691355, 4205.411242426002, 4217.051163488252, 4219.409282700424, 4234.153169366139, 4239.215745087169, 3274.476083826576, 3339.1985923378215, 3339.382214290364, 3353.245519758084, 3376.898693039213, 982.4891056650501, 997.8802543694803, 1006.2201793610011, 1014.761531040205, 1018.5467466977273, 960.0399600399601, 1008.1380419741163, 1031.3141760729181, 1077.902988731018, 1097.868255809308, 7187.173475050332, 7211.170715367695, 7224.096987876515, 7229.277072292729, 7242.746503872445, 598.7934162713943, 609.1471939285036, 610.531671330451, 610.703808652803, 743.4609907816789, 5450.618456707993, 5539.473749993825, 5546.112621980464, 5562.554995600342, 5587.580931430078, 9039.276857851357, 9104.089591040974, 9436.764080898032, 9468.715938521855, 9581.041895810502, 9357.812843743088, 9430.19843313326, 9437.811243775086, 9444.8583271251, 9473.478958657202, 7202.315780000997, 7388.889166662504, 7465.738699145504, 7477.177510473953, 7513.361364284097, 7040.260772619006, 7074.080369551925, 7094.645267736696, 7128.108986376703, 7154.0, 8158.714444994397, 8161.959190204011, 8350.498970061815, 8373.916260837314, 8556.74329770108, 8530.488170709777, 8558.229759321692, 8611.82776344482, 8634.0, 8680.565971701515, 6463.7737679181, 6542.34576542361, 6554.279029306867, 6572.8356791080605, 6577.736890524326, 7504.1370242420635, 7512.8873066905135, 7527.8494430109995, 7530.9246907532415, 7539.585322807298, 6894.8621027578165, 6909.861802763816, 7072.893906591303, 7143.0, 7236.312550307713, 6729.226138993882, 6851.0, 6854.862902742017, 6855.348741869514, 6906.998485219716, 6771.255161932282, 6869.107016087876, 6895.586264824126, 6907.102076729993, 6909.412699920563, 6050.606710563799, 6151.446369826737, 6171.537134714825, 6175.722092505938, 6195.721192546256, 6346.809595712136, 6374.90437643445, 6376.266729326001, 6440.323766004502, 6493.642849643315], "unit": "score", "name": "mootools.html", "value": 4319.113380607827}, {"lowerIsBetter": false, "replicates": [335.8774047472672, 341.3241781273079, 343.4676251809695, 343.99140021499477, 349.5420998491976, 6167.599106058103, 6224.128621992924, 6260.968695156529, 6265.0, 6329.33541978092, 6092.66490343031, 6197.5041996640275, 6264.906026409596, 6273.843153921154, 6281.780137695182, 4827.565519103271, 4830.347903033081, 4832.420109586855, 4838.9032219355595, 4839.540243676845, 4840.806367745286, 4843.612510999129, 4850.830220942268, 4852.708837469745, 4857.1742803723455, 4733.644976626767, 4808.927866082012, 4812.061647978646, 4819.590334821544, 4829.951700483003, 4784.282357646381, 4797.376341075638, 4805.303231031516, 4809.735464549449, 4817.710937343735, 4212.662986961066, 4212.662986961066, 4222.9577704222875, 4232.682548808821, 4245.469316335458, 5979.880402391927, 5992.310884248323, 6005.849853753647, 6011.909821352683, 6017.69911504423, 5460.836174914759, 5609.1305847593685, 5609.747561359749, 5625.128105143709, 5631.5776316776, 6580.605163690194, 6582.670866456658, 6645.06969024337, 6647.501437392215, 6655.101561289261, 4669.463011753658, 4675.859724208279, 4681.695689780154, 4683.15703173432, 4685.2972054191805, 6721.798346049626, 6877.89683154753, 6920.342567456084, 6978.337057979484, 6985.615791131486, 4661.836835710734, 4699.95300047002, 4707.576318131385, 4708.270218116198, 4713.6464765142755, 4763.618910487153, 4765.309030190603, 4770.165221086296, 4770.809167633256, 4771.880702982453, 5531.059719847555, 5534.335879694462, 5537.667739935617, 5539.556835453154, 5542.778288868481, 6524.510661700391, 6662.200535935719, 6662.86674266512, 6665.866682666319, 6728.259891411941, 1640.5078476457015, 1658.4941592814066, 1680.0843540270582, 1682.5204816627447, 1686.1569215392303, 1092.6667366453148, 1104.4036220441033, 1111.822108462642, 1112.477135746198, 1117.636768050387, 6323.652199129, 6324.494040476751, 6328.968355158195, 6330.746770129143, 6338.144350512714, 6801.2858649841055, 6845.418139458102, 6853.588784672836, 6854.0, 6859.348361905611, 6113.663748493786, 6251.3123556408755, 6265.937340626627, 6313.053042043638, 6321.841953951096, 3715.0, 3732.8133593320226, 3736.6823819975607, 3740.1958578905665, 3741.0, 7094.148702155774, 7129.857402851914, 7135.4648401370105, 7156.964215178891, 7161.212266650664, 6957.8956315655305, 7006.544574602634, 7008.894866577006, 7032.718691252395, 7067.43460523157, 7264.091988501437, 7307.89038164428, 7316.231795661485, 7343.926560734431, 7348.70605175787, 7036.472264580075, 7037.437005039687, 7040.471964602778, 7040.683169257293, 7050.224475307609, 6788.558743681645, 6923.861522769415, 6947.513674042971, 6947.652617369213, 6955.686994085379, 7231.566106033655, 7240.782776516713, 7255.129384473897, 7257.927420725725, 7274.781756547312, 4656.67403281767, 4706.035262771192, 4711.670183087288, 4731.266653668549, 4741.5495527924795, 6848.657567121524, 7009.719611215494, 7019.0, 7025.332593403618, 7031.578105313698, 6790.8641827164165, 6802.319768023158, 6802.93197068023, 6814.352636499525, 6818.931810682028, 6777.525573209828, 6784.050232967487, 6785.253622101466, 6788.049673045679, 6806.081179040964, 6534.281229064894, 6663.333666633298, 6680.498962577729, 6680.4989625779235, 6682.064510968371, 6835.897461537981, 6836.418904393182, 6841.3842754152365, 6844.760433384808, 6856.41720453767, 6658.0, 6689.0, 6733.764318248838, 6735.494837887276, 6739.460843132636], "unit": "score", "name": "prototype.html", "value": 5046.054725146185}, {"lowerIsBetter": false, "replicates": [797.6530209358925, 801.6713147609481, 803.7789607857839, 817.2032268538175, 849.5624753252074, 12699.428525716341, 12856.48574057039, 12857.742845143091, 12868.806967895489, 12885.742285154303, 12856.871431285685, 12972.0, 13080.73838523229, 13097.279649619268, 14379.209143497104, 826.1119296755982, 833.0461621443474, 833.7665453672981, 837.4682076881163, 839.95380254086, 824.1593574553951, 827.4538804389105, 828.0642873552907, 830.0495932157676, 830.4933990265932, 874.9325822496544, 875.8423483772918, 877.0089798527687, 877.6094637886143, 879.5162660536711, 873.5501216873315, 873.9257163141141, 874.6545114679698, 875.3609864798701, 882.4793371910539, 646.3310473659786, 647.8445173158408, 648.3743187823726, 649.4544582550633, 650.6616559389091, 14206.147631142165, 14258.500952466718, 14281.14313141215, 14337.283135843167, 14364.138151710826, 12216.633500994896, 12295.877041229653, 12460.75078498425, 12540.122191446602, 13108.80336794949, 9875.211062154687, 10556.261061725681, 10641.095506881924, 10690.893091069067, 10932.070773984142, 3549.2901419715904, 3635.9272814543824, 3643.1802844360072, 3658.0489072840987, 3669.412893936957, 41591.584084159076, 42561.0, 45911.77044114791, 47662.76168619169, 47687.76156119232, 9981.80036399268, 10025.598976041023, 10111.3427627204, 10442.63450779219, 10543.578256869792, 18417.079146042644, 18437.26250949974, 18486.722699159523, 18497.075146242903, 18511.53721156982, 7665.655045522964, 7836.294733473901, 7997.920020799834, 8182.672693092329, 8188.344932405394, 4308.655307575386, 4455.554444555583, 4464.598186163261, 4476.08240310742, 4495.820167193341, 3012.969870301269, 3047.360054388603, 3051.343961048385, 3052.4658184817567, 3056.69433056697, 519.5142541723425, 543.4701166362764, 549.8515400841831, 562.9240052592847, 564.7091747749912, 605.4006533531772, 658.3285049249738, 679.7077256779534, 681.0873429604354, 701.8526109516956, 8289.668413263522, 8457.281131103802, 8495.532745699045, 8642.611082501302, 8644.351673624504, 561.6573889927141, 638.4222278837659, 683.8852670147628, 699.6208313844121, 725.0, 3975.363941769303, 4184.225918205142, 4284.400183974246, 4298.376735373416, 4434.290513517822, 56262.156067659016, 57146.714266428404, 57208.0, 57280.0, 57299.0, 48151.27773083407, 48593.757031215326, 49022.26466603004, 49318.26022609664, 53537.73231133819, 44172.779136104116, 45661.77169114133, 49038.01923961501, 49911.0, 49967.0, 8320.16798320163, 8616.827663446571, 8902.688405905763, 8936.374453788432, 9033.593488293174, 33636.99089027333, 34109.65890341065, 34412.48381274233, 34563.30873382569, 35603.0, 42445.575544245396, 42591.14817703567, 42837.0, 43347.0, 43385.13229735451, 11710.386370187782, 12006.339651319262, 12006.579769708018, 12272.325022123869, 12416.068794840243, 12180.21574843984, 12321.50713971467, 12389.62831115068, 12623.431945562288, 12751.808722868978, 11025.669229923114, 11231.719207019563, 11757.588484403004, 11769.941150294193, 12029.097817663886, 11162.720931976766, 11241.437928103725, 11576.131790115944, 11756.529738810694, 11776.470058847544, 10707.196960227859, 10963.397013164353, 11074.843784312474, 11121.443927803739, 11219.49512271966, 9332.766680832761, 9488.525573721148, 9547.713568592953, 9552.952235239058, 9728.659496917573, 7884.207230089438, 8393.571689055108, 8405.70580029696, 9223.169914707709, 9233.0], "unit": "score", "name": "yui.html", "value": 6359.347000715759}], "name": "dromaeo_css", "value": 6889.8359985039615}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 109.0, 112.0, 121.0, 111.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 148.0, 169.0, 127.0, 154.0, 149.0, 128.0, 161.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 164.0, 161.0, 164.0, 173.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 75.0, 72.0, 70.0, 131.0, 73.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 145.0, 96.0, 98.0, 96.0, 140.0, 96.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [60.0, 57.0, 62.0, 58.0, 59.0, 60.0, 61.0, 57.0, 65.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 69.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 94.0, 88.0, 87.0, 87.0, 87.0, 99.0, 87.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 122.0, 121.0, 120.0, 128.0, 125.0, 119.0, 122.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [153.0, 153.0, 160.0, 153.0, 148.0, 141.0, 162.0, 150.0, 150.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.2}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1521.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "Richards", "value": 211.03535600000004}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [732.0644216691069], "unit": "score", "name": "Earley", "value": 910.388458}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25275.0], "unit": "score", "name": "RegExp", "value": 36.042927794263136}, {"lowerIsBetter": false, "replicates": [557.1030640668523], "unit": "score", "name": "Splay", "value": 146.27634499999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21452.429188576876}]} 23:20:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21452.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1521.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6889.84"}}} 23:20:42 INFO - Return code: 0 23:20:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:20:42 INFO - # TBPL SUCCESS # 23:20:42 INFO - Running post-action listener: _resource_record_post_action 23:20:42 INFO - Running post-run listener: _resource_record_post_run 23:20:43 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 536576; Write bytes: 395759616; Read time: 248; Write time: 239088 23:20:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79478784; Read time: 0; Write time: 51056 23:20:43 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 536576; Write bytes: 223211520; Read time: 248; Write time: 127380 23:20:43 INFO - Running post-run listener: _upload_blobber_files 23:20:43 INFO - Blob upload gear active. 23:20:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:20:43 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:43 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:43 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:43 INFO - (blobuploader) - INFO - Open directory for files ... 23:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:20:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:44 INFO - (blobuploader) - INFO - Done attempting. 23:20:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:20:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:45 INFO - (blobuploader) - INFO - Done attempting. 23:20:45 INFO - (blobuploader) - INFO - Iteration through files over. 23:20:45 INFO - Return code: 0 23:20:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:20:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:20:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8ceb50ef41c6c1ea187d93ec1378610d9179dd502cffba2d728da5661e0f9f50dba2db56249dde3ae7825134c9f65b72dff25b19b054e287be60955dcf7dbc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f801c2f0bde418e562f445081ded9e81529fcc9dd283418f054154c14a48cb78b91dbc07c8ae8eaa6d7b9dc24cff62e45f4e73b5e5ea96c70f2b50d206dbfc"} 23:20:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:20:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:20:45 INFO - Contents: 23:20:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8ceb50ef41c6c1ea187d93ec1378610d9179dd502cffba2d728da5661e0f9f50dba2db56249dde3ae7825134c9f65b72dff25b19b054e287be60955dcf7dbc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f801c2f0bde418e562f445081ded9e81529fcc9dd283418f054154c14a48cb78b91dbc07c8ae8eaa6d7b9dc24cff62e45f4e73b5e5ea96c70f2b50d206dbfc"} 23:20:45 INFO - Copying logs to upload dir... 23:20:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.694258 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-05 23:20:45.618014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:45.621742) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8ceb50ef41c6c1ea187d93ec1378610d9179dd502cffba2d728da5661e0f9f50dba2db56249dde3ae7825134c9f65b72dff25b19b054e287be60955dcf7dbc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f801c2f0bde418e562f445081ded9e81529fcc9dd283418f054154c14a48cb78b91dbc07c8ae8eaa6d7b9dc24cff62e45f4e73b5e5ea96c70f2b50d206dbfc"} 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.011321 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8ceb50ef41c6c1ea187d93ec1378610d9179dd502cffba2d728da5661e0f9f50dba2db56249dde3ae7825134c9f65b72dff25b19b054e287be60955dcf7dbc2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f801c2f0bde418e562f445081ded9e81529fcc9dd283418f054154c14a48cb78b91dbc07c8ae8eaa6d7b9dc24cff62e45f4e73b5e5ea96c70f2b50d206dbfc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:45.646525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:45.646850) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452063037.849678-431337812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 23:20:45.731237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 23:20:45.731564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 23:20:45.731875) ========= ========= Total master_lag: 0.20 =========