builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1450791910.38 results: success (0) buildid: 20151222030207 builduid: 1f19cd31c84549e385e64290c9295b8f revision: ad16863d1d45bd3fd7906c76fa1ac1e12d24a133 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.379561) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.380144) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.380505) ========= 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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006086 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.403975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.404345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.417655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.418024) ========= 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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.467653) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.467998) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.468460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.468773) ========= 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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 05:45:11-- 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% 22.2M=0.001s 2015-12-22 05:45:11 (22.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.568798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.569153) ========= 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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021554 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.619503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:10.619894) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad16863d1d45bd3fd7906c76fa1ac1e12d24a133 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ad16863d1d45bd3fd7906c76fa1ac1e12d24a133 --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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 05:45:12,001 truncating revision to first 12 chars 2015-12-22 05:45:12,002 Setting DEBUG logging. 2015-12-22 05:45:12,002 attempt 1/10 2015-12-22 05:45:12,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad16863d1d45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 05:45:12,511 unpacking tar archive at: mozilla-central-ad16863d1d45/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825922 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:11.459436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:11.459803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:11.470130) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:11.470459) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 05:45:11.470939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-22 05:45:11.471266) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:12 INFO - MultiFileLogger online at 20151222 05:45:12 in /builds/slave/test-pgo 05:45:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:45:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:45:12 INFO - {'append_to_log': False, 05:45:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:45:12 INFO - 'blob_upload_branch': 'Firefox', 05:45:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:45:12 INFO - 'branch': 'Firefox', 05:45:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:12 INFO - 'config_files': ('talos/linux_config.py',), 05:45:12 INFO - 'default_actions': ('clobber', 05:45:12 INFO - 'read-buildbot-config', 05:45:12 INFO - 'download-and-extract', 05:45:12 INFO - 'populate-webroot', 05:45:12 INFO - 'create-virtualenv', 05:45:12 INFO - 'install', 05:45:12 INFO - 'run-tests'), 05:45:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:12 INFO - 'download_minidump_stackwalk': True, 05:45:12 INFO - 'download_symbols': 'ondemand', 05:45:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:12 INFO - 'installer_path': 'installer.exe', 05:45:12 INFO - 'log_level': 'info', 05:45:12 INFO - 'log_name': 'talos', 05:45:12 INFO - 'log_to_console': True, 05:45:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:12 INFO - 'opt_config_files': (), 05:45:12 INFO - 'pip_index': False, 05:45:12 INFO - 'sps_profile': False, 05:45:12 INFO - 'sps_profile_interval': 0, 05:45:12 INFO - 'suite': 'dromaeojs', 05:45:12 INFO - 'system_bits': '64', 05:45:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:12 INFO - 'title': 'talos-linux64-ix-059', 05:45:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:12 INFO - 'use_talos_json': True, 05:45:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:45:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:12 INFO - 'work_dir': 'build'} 05:45:12 INFO - ##### 05:45:12 INFO - ##### Running clobber step. 05:45:12 INFO - ##### 05:45:12 INFO - Running pre-action listener: _resource_record_pre_action 05:45:12 INFO - Running main action method: clobber 05:45:12 INFO - rmtree: /builds/slave/test-pgo/build 05:45:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:45:13 INFO - Running post-action listener: _resource_record_post_action 05:45:13 INFO - ##### 05:45:13 INFO - ##### Running read-buildbot-config step. 05:45:13 INFO - ##### 05:45:13 INFO - Running pre-action listener: _resource_record_pre_action 05:45:13 INFO - Running main action method: read_buildbot_config 05:45:13 INFO - Using buildbot properties: 05:45:13 INFO - { 05:45:13 INFO - "project": "", 05:45:13 INFO - "product": "firefox", 05:45:13 INFO - "script_repo_revision": "production", 05:45:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:45:13 INFO - "repository": "", 05:45:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:45:13 INFO - "buildid": "20151222030207", 05:45:13 INFO - "stage_platform": "linux64-pgo", 05:45:13 INFO - "basedir": "/builds/slave/test-pgo", 05:45:13 INFO - "nightly_build": "True", 05:45:13 INFO - "buildnumber": 290, 05:45:13 INFO - "slavename": "talos-linux64-ix-059", 05:45:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:45:13 INFO - "platform": "ubuntu64_hw", 05:45:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:13 INFO - "branch": "mozilla-central", 05:45:13 INFO - "repo_path": "mozilla-central", 05:45:13 INFO - "revision": "ad16863d1d45bd3fd7906c76fa1ac1e12d24a133", 05:45:13 INFO - "pgo_build": "True", 05:45:13 INFO - "builduid": "1f19cd31c84549e385e64290c9295b8f", 05:45:13 INFO - "slavebuilddir": "test" 05:45:13 INFO - } 05:45:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:45:13 INFO - Running post-action listener: _resource_record_post_action 05:45:13 INFO - ##### 05:45:13 INFO - ##### Running download-and-extract step. 05:45:13 INFO - ##### 05:45:13 INFO - Running pre-action listener: _resource_record_pre_action 05:45:13 INFO - Running main action method: download_and_extract 05:45:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:45:13 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')]} 05:45:13 INFO - https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/test_packages.json 05:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/test_packages.json 05:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:45:14 INFO - Downloaded 1302 bytes. 05:45:14 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:45:14 INFO - Using the following test package requirements: 05:45:14 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:14 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:14 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:14 INFO - u'jsshell-linux-x86_64.zip'], 05:45:14 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:14 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:14 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:14 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:14 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:14 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:14 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:14 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:14 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:14 INFO - https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:14 INFO - Downloaded 23176164 bytes. 05:45:14 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 05:45:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:14 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 05:45:16 INFO - Return code: 0 05:45:16 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 05:45:16 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')]} 05:45:16 INFO - https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:17 INFO - Downloaded 23176164 bytes. 05:45:17 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 05:45:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:17 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 05:45:18 INFO - Return code: 0 05:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:18 INFO - https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:19 INFO - Downloaded 11132277 bytes. 05:45:19 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 05:45:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:19 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 05:45:19 INFO - Return code: 0 05:45:19 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')]} 05:45:19 INFO - https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/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 05:45:20 INFO - Downloaded 54907810 bytes. 05:45:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:20 INFO - mkdir: /builds/slave/test-pgo/properties 05:45:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:45:20 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:45:20 INFO - Contents: 05:45:20 INFO - build_url:https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:20 INFO - Running post-action listener: _resource_record_post_action 05:45:20 INFO - Running post-action listener: set_extra_try_arguments 05:45:20 INFO - ##### 05:45:20 INFO - ##### Running populate-webroot step. 05:45:20 INFO - ##### 05:45:20 INFO - Running pre-action listener: _resource_record_pre_action 05:45:20 INFO - Running main action method: populate_webroot 05:45:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:20 INFO - '--tppagecycles', 05:45:20 INFO - '7'], 05:45:20 INFO - 'tests': ['tsvgm']}}, 05:45:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:45:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'tests': ['damp', 'tps']}, 05:45:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['damp', 'tps']}, 05:45:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:45:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:20 INFO - 'other': {'tests': ['a11yr', 05:45:20 INFO - 'ts_paint', 05:45:20 INFO - 'tpaint', 05:45:20 INFO - 'sessionrestore', 05:45:20 INFO - 'sessionrestore_no_auto_restore']}, 05:45:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['a11yr', 05:45:20 INFO - 'ts_paint', 05:45:20 INFO - 'tpaint', 05:45:20 INFO - 'sessionrestore', 05:45:20 INFO - 'sessionrestore_no_auto_restore']}, 05:45:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['a11yr', 05:45:20 INFO - 'ts_paint', 05:45:20 INFO - 'tpaint', 05:45:20 INFO - 'sessionrestore', 05:45:20 INFO - 'sessionrestore_no_auto_restore']}, 05:45:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['a11yr', 05:45:20 INFO - 'ts_paint', 05:45:20 INFO - 'tpaint', 05:45:20 INFO - 'sessionrestore', 05:45:20 INFO - 'sessionrestore_no_auto_restore']}, 05:45:20 INFO - 'other_l64': {'tests': ['a11yr', 05:45:20 INFO - 'ts_paint', 05:45:20 INFO - 'tpaint', 05:45:20 INFO - 'sessionrestore', 05:45:20 INFO - 'sessionrestore_no_auto_restore']}, 05:45:20 INFO - 'other_nol64': {'tests': ['a11yr', 05:45:20 INFO - 'ts_paint', 05:45:20 INFO - 'tpaint', 05:45:20 INFO - 'sessionrestore', 05:45:20 INFO - 'sessionrestore_no_auto_restore']}, 05:45:20 INFO - 'svgr': {'tests': ['tsvgx', 05:45:20 INFO - 'tsvgr_opacity', 05:45:20 INFO - 'tart', 05:45:20 INFO - 'tscrollx', 05:45:20 INFO - 'cart']}, 05:45:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['tsvgx', 05:45:20 INFO - 'tsvgr_opacity', 05:45:20 INFO - 'tart', 05:45:20 INFO - 'tscrollx', 05:45:20 INFO - 'cart']}, 05:45:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'tests': ['tp5o']}, 05:45:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'talos_options': ['--e10s'], 05:45:20 INFO - 'tests': ['tp5o']}, 05:45:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'talos_options': ['--xperf_path', 05:45:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:20 INFO - 'tests': ['tp5n']}, 05:45:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:20 INFO - 'talos_options': ['--e10s', 05:45:20 INFO - '--xperf_path', 05:45:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:20 INFO - 'tests': ['tp5n']}}, 05:45:20 INFO - 'talos.zip': {'path': '', 05:45:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:20 INFO - Running post-action listener: _resource_record_post_action 05:45:20 INFO - ##### 05:45:20 INFO - ##### Running create-virtualenv step. 05:45:20 INFO - ##### 05:45:20 INFO - Running pre-action listener: _resource_record_pre_action 05:45:20 INFO - Running main action method: create_virtualenv 05:45:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:45:20 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 05:45:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:45:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:20 INFO - Using real prefix '/usr' 05:45:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:45:21 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:23 INFO - Installing pip.................done. 05:45:23 INFO - Return code: 0 05:45:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:45:23 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')]} 05:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:23 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')]} 05:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:23 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:23 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 05:45:23 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 05:45:23 INFO - Using env: {'DISPLAY': ':0', 05:45:23 INFO - 'HOME': '/home/cltbld', 05:45:23 INFO - 'LANG': 'en_US.UTF-8', 05:45:23 INFO - 'LANGUAGE': 'en_US:en', 05:45:23 INFO - 'LOGNAME': 'cltbld', 05:45:23 INFO - 'MAIL': '/var/mail/cltbld', 05:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:23 INFO - 'MOZ_NO_REMOTE': '1', 05:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:23 INFO - 'NO_EM_RESTART': '1', 05:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:23 INFO - 'SHELL': '/bin/bash', 05:45:23 INFO - 'SHLVL': '1', 05:45:23 INFO - 'TERM': 'linux', 05:45:23 INFO - 'TMOUT': '86400', 05:45:23 INFO - 'USER': 'cltbld', 05:45:23 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:23 INFO - '_': '/tools/buildbot/bin/python'} 05:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:23 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 05:45:23 INFO - Cleaning up... 05:45:23 INFO - Return code: 0 05:45:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:45:23 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')]} 05:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:23 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')]} 05:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:23 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:23 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 05:45:23 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 05:45:23 INFO - Using env: {'DISPLAY': ':0', 05:45:23 INFO - 'HOME': '/home/cltbld', 05:45:23 INFO - 'LANG': 'en_US.UTF-8', 05:45:23 INFO - 'LANGUAGE': 'en_US:en', 05:45:23 INFO - 'LOGNAME': 'cltbld', 05:45:23 INFO - 'MAIL': '/var/mail/cltbld', 05:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:23 INFO - 'MOZ_NO_REMOTE': '1', 05:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:23 INFO - 'NO_EM_RESTART': '1', 05:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:23 INFO - 'SHELL': '/bin/bash', 05:45:23 INFO - 'SHLVL': '1', 05:45:23 INFO - 'TERM': 'linux', 05:45:23 INFO - 'TMOUT': '86400', 05:45:23 INFO - 'USER': 'cltbld', 05:45:23 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:23 INFO - '_': '/tools/buildbot/bin/python'} 05:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:23 INFO - Downloading/unpacking psutil>=0.7.1 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:25 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:45:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:45:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:25 INFO - Installing collected packages: psutil 05:45:25 INFO - Running setup.py install for psutil 05:45:25 INFO - building 'psutil._psutil_linux' extension 05:45:25 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 05:45:25 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 05:45:25 INFO - building 'psutil._psutil_posix' extension 05:45:25 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 05:45:25 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 05:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:25 INFO - Successfully installed psutil 05:45:25 INFO - Cleaning up... 05:45:26 INFO - Return code: 0 05:45:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:45:26 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')]} 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 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')]} 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:26 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 05:45:26 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 05:45:26 INFO - Using env: {'DISPLAY': ':0', 05:45:26 INFO - 'HOME': '/home/cltbld', 05:45:26 INFO - 'LANG': 'en_US.UTF-8', 05:45:26 INFO - 'LANGUAGE': 'en_US:en', 05:45:26 INFO - 'LOGNAME': 'cltbld', 05:45:26 INFO - 'MAIL': '/var/mail/cltbld', 05:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:26 INFO - 'MOZ_NO_REMOTE': '1', 05:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:26 INFO - 'NO_EM_RESTART': '1', 05:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:26 INFO - 'SHELL': '/bin/bash', 05:45:26 INFO - 'SHLVL': '1', 05:45:26 INFO - 'TERM': 'linux', 05:45:26 INFO - 'TMOUT': '86400', 05:45:26 INFO - 'USER': 'cltbld', 05:45:26 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:26 INFO - '_': '/tools/buildbot/bin/python'} 05:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:26 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 05:45:26 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 05:45:26 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 05:45:26 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 05:45:26 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 05:45:26 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 05:45:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:45:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:45:27 INFO - Installing collected packages: mozsystemmonitor 05:45:27 INFO - Running setup.py install for mozsystemmonitor 05:45:28 INFO - Successfully installed mozsystemmonitor 05:45:28 INFO - Cleaning up... 05:45:28 INFO - Return code: 0 05:45:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:45:28 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')]} 05:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:28 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')]} 05:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:28 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:28 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 05:45:28 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 05:45:28 INFO - Using env: {'DISPLAY': ':0', 05:45:28 INFO - 'HOME': '/home/cltbld', 05:45:28 INFO - 'LANG': 'en_US.UTF-8', 05:45:28 INFO - 'LANGUAGE': 'en_US:en', 05:45:28 INFO - 'LOGNAME': 'cltbld', 05:45:28 INFO - 'MAIL': '/var/mail/cltbld', 05:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:28 INFO - 'MOZ_NO_REMOTE': '1', 05:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:28 INFO - 'NO_EM_RESTART': '1', 05:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:28 INFO - 'SHELL': '/bin/bash', 05:45:28 INFO - 'SHLVL': '1', 05:45:28 INFO - 'TERM': 'linux', 05:45:28 INFO - 'TMOUT': '86400', 05:45:28 INFO - 'USER': 'cltbld', 05:45:28 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:28 INFO - '_': '/tools/buildbot/bin/python'} 05:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:28 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 05:45:28 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 05:45:28 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 05:45:28 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 05:45:28 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 05:45:28 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 05:45:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:45:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:45:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 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 05:45:30 INFO - Downloading docopt-0.6.1.tar.gz 05:45:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:45:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:30 INFO - Running setup.py install for blobuploader 05:45:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:30 INFO - Running setup.py install for requests 05:45:31 INFO - Running setup.py install for docopt 05:45:31 INFO - Successfully installed blobuploader requests docopt 05:45:31 INFO - Cleaning up... 05:45:31 INFO - Return code: 0 05:45:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:31 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')]} 05:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:31 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')]} 05:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:31 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:31 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 05:45:31 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 05:45:31 INFO - Using env: {'DISPLAY': ':0', 05:45:31 INFO - 'HOME': '/home/cltbld', 05:45:31 INFO - 'LANG': 'en_US.UTF-8', 05:45:31 INFO - 'LANGUAGE': 'en_US:en', 05:45:31 INFO - 'LOGNAME': 'cltbld', 05:45:31 INFO - 'MAIL': '/var/mail/cltbld', 05:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:31 INFO - 'MOZ_NO_REMOTE': '1', 05:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:31 INFO - 'NO_EM_RESTART': '1', 05:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:31 INFO - 'SHELL': '/bin/bash', 05:45:31 INFO - 'SHLVL': '1', 05:45:31 INFO - 'TERM': 'linux', 05:45:31 INFO - 'TMOUT': '86400', 05:45:31 INFO - 'USER': 'cltbld', 05:45:31 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:31 INFO - '_': '/tools/buildbot/bin/python'} 05:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:31 INFO - Running setup.py (path:/tmp/pip-CVlc1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:31 INFO - Running setup.py (path:/tmp/pip-AQyJP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:31 INFO - Running setup.py (path:/tmp/pip-hmzZLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:31 INFO - Running setup.py (path:/tmp/pip-pj0nWt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:31 INFO - Running setup.py (path:/tmp/pip-f8yCtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:31 INFO - Running setup.py (path:/tmp/pip-MDOgbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:31 INFO - Running setup.py (path:/tmp/pip-G2tqzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:32 INFO - Running setup.py (path:/tmp/pip-pkXtEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:32 INFO - Running setup.py (path:/tmp/pip-y7ZYaq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:32 INFO - Running setup.py (path:/tmp/pip-nzAvRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:32 INFO - Running setup.py (path:/tmp/pip-RoiRHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:32 INFO - Running setup.py (path:/tmp/pip-0n_Gk6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:32 INFO - Running setup.py (path:/tmp/pip-03FOln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:32 INFO - Running setup.py (path:/tmp/pip-apuIlO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:32 INFO - Running setup.py (path:/tmp/pip-dmEoSm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:32 INFO - Running setup.py (path:/tmp/pip-TmXEVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:32 INFO - Running setup.py (path:/tmp/pip-Si5V5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:32 INFO - Running setup.py install for manifestparser 05:45:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:32 INFO - Running setup.py install for mozcrash 05:45:32 INFO - Running setup.py install for mozdebug 05:45:33 INFO - Running setup.py install for mozdevice 05:45:33 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Running setup.py install for mozfile 05:45:33 INFO - Running setup.py install for mozhttpd 05:45:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Running setup.py install for mozinfo 05:45:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Running setup.py install for mozInstall 05:45:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Running setup.py install for mozleak 05:45:33 INFO - Running setup.py install for mozlog 05:45:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Running setup.py install for moznetwork 05:45:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:33 INFO - Running setup.py install for mozprocess 05:45:34 INFO - Running setup.py install for mozprofile 05:45:34 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:34 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:34 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:34 INFO - Running setup.py install for mozrunner 05:45:34 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:34 INFO - Running setup.py install for mozscreenshot 05:45:34 INFO - Running setup.py install for moztest 05:45:34 INFO - Running setup.py install for mozversion 05:45:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:34 INFO - Cleaning up... 05:45:34 INFO - Return code: 0 05:45:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:34 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:34 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 05:45:34 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 05:45:34 INFO - Using env: {'DISPLAY': ':0', 05:45:34 INFO - 'HOME': '/home/cltbld', 05:45:34 INFO - 'LANG': 'en_US.UTF-8', 05:45:34 INFO - 'LANGUAGE': 'en_US:en', 05:45:34 INFO - 'LOGNAME': 'cltbld', 05:45:34 INFO - 'MAIL': '/var/mail/cltbld', 05:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:34 INFO - 'MOZ_NO_REMOTE': '1', 05:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:34 INFO - 'NO_EM_RESTART': '1', 05:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:34 INFO - 'SHELL': '/bin/bash', 05:45:34 INFO - 'SHLVL': '1', 05:45:34 INFO - 'TERM': 'linux', 05:45:34 INFO - 'TMOUT': '86400', 05:45:34 INFO - 'USER': 'cltbld', 05:45:34 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:34 INFO - '_': '/tools/buildbot/bin/python'} 05:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:34 INFO - Running setup.py (path:/tmp/pip-BOVAgu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:34 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)) 05:45:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:34 INFO - Running setup.py (path:/tmp/pip-J0J_KM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:34 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)) 05:45:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:34 INFO - Running setup.py (path:/tmp/pip-KnjTE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:35 INFO - Running setup.py (path:/tmp/pip-va4eGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:35 INFO - Running setup.py (path:/tmp/pip-hdqTen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:35 INFO - Running setup.py (path:/tmp/pip-qWn6c7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:35 INFO - Running setup.py (path:/tmp/pip-tn0Sg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:35 INFO - Running setup.py (path:/tmp/pip-r3mx6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:35 INFO - Running setup.py (path:/tmp/pip-f48b_g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:35 INFO - Running setup.py (path:/tmp/pip-NOmooA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:35 INFO - Running setup.py (path:/tmp/pip-2Zz_24-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:35 INFO - Running setup.py (path:/tmp/pip-KX1ORR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:35 INFO - Running setup.py (path:/tmp/pip-2jOZKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:35 INFO - Running setup.py (path:/tmp/pip-f6vnLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:35 INFO - Running setup.py (path:/tmp/pip-z2hSr7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:35 INFO - Running setup.py (path:/tmp/pip-RwlPWE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:35 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)) 05:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:35 INFO - Running setup.py (path:/tmp/pip-fM_DCA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:36 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)) 05:45:36 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)) 05:45:36 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)) 05:45:36 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)) 05:45:36 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)) 05:45:36 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)) 05:45:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:36 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 05:45:36 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 05:45:36 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 05:45:36 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 05:45:36 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 05:45:36 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 05:45:37 INFO - Downloading blessings-1.5.1.tar.gz 05:45:37 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 05:45:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:37 INFO - Installing collected packages: blessings 05:45:37 INFO - Running setup.py install for blessings 05:45:37 INFO - Successfully installed blessings 05:45:37 INFO - Cleaning up... 05:45:37 INFO - Return code: 0 05:45:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:38 INFO - Reading from file tmpfile_stdout 05:45:38 INFO - Current package versions: 05:45:38 INFO - argparse == 1.2.1 05:45:38 INFO - blessings == 1.5.1 05:45:38 INFO - blobuploader == 1.2.4 05:45:38 INFO - docopt == 0.6.1 05:45:38 INFO - manifestparser == 1.1 05:45:38 INFO - mozInstall == 1.12 05:45:38 INFO - mozcrash == 0.16 05:45:38 INFO - mozdebug == 0.1 05:45:38 INFO - mozdevice == 0.47 05:45:38 INFO - mozfile == 1.2 05:45:38 INFO - mozhttpd == 0.7 05:45:38 INFO - mozinfo == 0.9 05:45:38 INFO - mozleak == 0.1 05:45:38 INFO - mozlog == 3.1 05:45:38 INFO - moznetwork == 0.27 05:45:38 INFO - mozprocess == 0.22 05:45:38 INFO - mozprofile == 0.28 05:45:38 INFO - mozrunner == 6.11 05:45:38 INFO - mozscreenshot == 0.1 05:45:38 INFO - mozsystemmonitor == 0.0 05:45:38 INFO - moztest == 0.7 05:45:38 INFO - mozversion == 1.4 05:45:38 INFO - psutil == 3.1.1 05:45:38 INFO - requests == 1.2.3 05:45:38 INFO - wsgiref == 0.1.2 05:45:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:38 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:38 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 05:45:38 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 05:45:38 INFO - Using env: {'DISPLAY': ':0', 05:45:38 INFO - 'HOME': '/home/cltbld', 05:45:38 INFO - 'LANG': 'en_US.UTF-8', 05:45:38 INFO - 'LANGUAGE': 'en_US:en', 05:45:38 INFO - 'LOGNAME': 'cltbld', 05:45:38 INFO - 'MAIL': '/var/mail/cltbld', 05:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:38 INFO - 'MOZ_NO_REMOTE': '1', 05:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:38 INFO - 'NO_EM_RESTART': '1', 05:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:38 INFO - 'SHELL': '/bin/bash', 05:45:38 INFO - 'SHLVL': '1', 05:45:38 INFO - 'TERM': 'linux', 05:45:38 INFO - 'TMOUT': '86400', 05:45:38 INFO - 'USER': 'cltbld', 05:45:38 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:38 INFO - '_': '/tools/buildbot/bin/python'} 05:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 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)) 05:45:38 INFO - Cleaning up... 05:45:38 INFO - Return code: 0 05:45:38 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:38 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:38 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 05:45:38 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 05:45:38 INFO - Using env: {'DISPLAY': ':0', 05:45:38 INFO - 'HOME': '/home/cltbld', 05:45:38 INFO - 'LANG': 'en_US.UTF-8', 05:45:38 INFO - 'LANGUAGE': 'en_US:en', 05:45:38 INFO - 'LOGNAME': 'cltbld', 05:45:38 INFO - 'MAIL': '/var/mail/cltbld', 05:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:38 INFO - 'MOZ_NO_REMOTE': '1', 05:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:38 INFO - 'NO_EM_RESTART': '1', 05:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:38 INFO - 'SHELL': '/bin/bash', 05:45:38 INFO - 'SHLVL': '1', 05:45:38 INFO - 'TERM': 'linux', 05:45:38 INFO - 'TMOUT': '86400', 05:45:38 INFO - 'USER': 'cltbld', 05:45:38 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:38 INFO - '_': '/tools/buildbot/bin/python'} 05:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:38 INFO - Downloading/unpacking jsonschema 05:45:38 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 05:45:38 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 05:45:38 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 05:45:38 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 05:45:38 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 05:45:38 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 05:45:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:40 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 05:45:40 INFO - Downloading/unpacking functools32 (from jsonschema) 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:45:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:40 INFO - warning: no files found matching '*.txt' 05:45:40 INFO - no previously-included directories found matching 'build' 05:45:40 INFO - no previously-included directories found matching 'dist' 05:45:40 INFO - no previously-included directories found matching '.git*' 05:45:40 INFO - Installing collected packages: jsonschema, functools32 05:45:40 INFO - Running setup.py install for functools32 05:45:40 INFO - warning: no files found matching '*.txt' 05:45:40 INFO - no previously-included directories found matching 'build' 05:45:40 INFO - no previously-included directories found matching 'dist' 05:45:40 INFO - no previously-included directories found matching '.git*' 05:45:40 INFO - Successfully installed jsonschema functools32 05:45:40 INFO - Cleaning up... 05:45:40 INFO - Return code: 0 05:45:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:45:40 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')]} 05:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:40 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')]} 05:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:40 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 0x7fc912c5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, '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': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', '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 05:45:40 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 05:45:40 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 05:45:40 INFO - Using env: {'DISPLAY': ':0', 05:45:40 INFO - 'HOME': '/home/cltbld', 05:45:40 INFO - 'LANG': 'en_US.UTF-8', 05:45:40 INFO - 'LANGUAGE': 'en_US:en', 05:45:40 INFO - 'LOGNAME': 'cltbld', 05:45:40 INFO - 'MAIL': '/var/mail/cltbld', 05:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:40 INFO - 'MOZ_NO_REMOTE': '1', 05:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:40 INFO - 'NO_EM_RESTART': '1', 05:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:40 INFO - 'SHELL': '/bin/bash', 05:45:40 INFO - 'SHLVL': '1', 05:45:40 INFO - 'TERM': 'linux', 05:45:40 INFO - 'TMOUT': '86400', 05:45:40 INFO - 'USER': 'cltbld', 05:45:40 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:40 INFO - '_': '/tools/buildbot/bin/python'} 05:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:40 INFO - Downloading/unpacking flake8 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:42 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 05:45:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:42 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 05:45:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:43 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 05:45:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:45:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:43 INFO - no previously-included directories found matching 'docs/_build' 05:45:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:43 INFO - Running setup.py install for pep8 05:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:43 INFO - no previously-included directories found matching 'docs/_build' 05:45:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:45:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:43 INFO - Cleaning up... 05:45:43 INFO - Return code: 0 05:45:43 INFO - Running post-action listener: _resource_record_post_action 05:45:43 INFO - Running post-action listener: _start_resource_monitoring 05:45:43 INFO - Starting resource monitoring. 05:45:43 INFO - ##### 05:45:43 INFO - ##### Running install step. 05:45:43 INFO - ##### 05:45:43 INFO - Running pre-action listener: _resource_record_pre_action 05:45:43 INFO - Running main action method: install 05:45:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:43 INFO - Reading from file tmpfile_stdout 05:45:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:45:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:45:43 INFO - Reading from file tmpfile_stdout 05:45:43 INFO - Output received: 05:45:43 INFO - Usage: mozinstall [options] installer 05:45:43 INFO - Options: 05:45:43 INFO - -h, --help show this help message and exit 05:45:43 INFO - -d DEST, --destination=DEST 05:45:43 INFO - Directory to install application into. [default: 05:45:43 INFO - "/builds/slave/test-pgo"] 05:45:43 INFO - --app=APP Application being installed. [default: firefox] 05:45:43 INFO - mkdir: /builds/slave/test-pgo/build/application 05:45:43 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'] 05:45:43 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 05:45:59 INFO - Reading from file tmpfile_stdout 05:45:59 INFO - Output received: 05:45:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:45:59 INFO - Running post-action listener: _resource_record_post_action 05:45:59 INFO - ##### 05:45:59 INFO - ##### Running run-tests step. 05:45:59 INFO - ##### 05:45:59 INFO - Running pre-action listener: _resource_record_pre_action 05:45:59 INFO - Running main action method: run_tests 05:45:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:45:59 INFO - Python 2.7.3 05:45:59 INFO - Return code: 0 05:45:59 INFO - grabbing minidump binary from tooltool 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 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 0x197f540>, '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 0x1980440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19808f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:45:59 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 05:45:59 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 05:45:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:59 INFO - Return code: 0 05:45:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:45:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:45:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:45:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:46:00 INFO - Return code: 0 05:46:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:46:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:46:00 INFO - Using env: {'DISPLAY': ':0', 05:46:00 INFO - 'HOME': '/home/cltbld', 05:46:00 INFO - 'LANG': 'en_US.UTF-8', 05:46:00 INFO - 'LANGUAGE': 'en_US:en', 05:46:00 INFO - 'LOGNAME': 'cltbld', 05:46:00 INFO - 'MAIL': '/var/mail/cltbld', 05:46:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:00 INFO - 'MOZ_NO_REMOTE': '1', 05:46:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:00 INFO - 'NO_EM_RESTART': '1', 05:46:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:46:00 INFO - 'SHELL': '/bin/bash', 05:46:00 INFO - 'SHLVL': '1', 05:46:00 INFO - 'TERM': 'linux', 05:46:00 INFO - 'TMOUT': '86400', 05:46:00 INFO - 'USER': 'cltbld', 05:46:00 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272', 05:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:00 INFO - '_': '/tools/buildbot/bin/python'} 05:46:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:46:00 INFO - mozversion application_buildid: 20151222030207 05:46:00 INFO - mozversion application_changeset: ad16863d1d45bd3fd7906c76fa1ac1e12d24a133 05:46:00 INFO - mozversion application_display_name: Nightly 05:46:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:00 INFO - mozversion application_name: Firefox 05:46:00 INFO - mozversion application_remotingname: firefox 05:46:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:00 INFO - mozversion application_vendor: Mozilla 05:46:00 INFO - mozversion application_version: 46.0a1 05:46:00 INFO - mozversion platform_buildid: 20151222030207 05:46:00 INFO - mozversion platform_changeset: ad16863d1d45bd3fd7906c76fa1ac1e12d24a133 05:46:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:00 INFO - mozversion platform_version: 46.0a1 05:46:00 INFO - using testdate: 1450791960 05:46:00 INFO - actual date: 1450791960 05:46:00 INFO - starting webserver on 'localhost:39543' 05:46:00 INFO - SUITE-START | Running 3 tests 05:46:00 INFO - TEST-START | dromaeo_css 05:46:00 INFO - operating with platform_type : linux_ 05:46:00 INFO - Initialising browser for dromaeo_css test... 05:46:00 INFO - TEST-INFO | started process 31944 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpziW56p/profile http://localhost:39543/getInfo.html) 05:46:04 INFO - PROCESS | 31944 | __metrics Screen width/height:1600/1200 05:46:04 INFO - PROCESS | 31944 | colorDepth:24 05:46:04 INFO - PROCESS | 31944 | Browser inner width/height: 1024/697 05:46:04 INFO - PROCESS | 31944 | __metrics 05:46:05 INFO - PROCESS | 31944 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:46:05 INFO - PROCESS | 31944 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:06 INFO - TEST-INFO | 31944: exit 0 05:46:06 INFO - Browser initialized. 05:46:06 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:06 INFO - TEST-INFO | started process 32036 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpziW56p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:17 INFO - PROCESS | 32036 | RSS: Main: 149909504 05:46:17 INFO - PROCESS | 32036 | 05:47:08 INFO - PROCESS | 32036 | 1450792028615 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:18 INFO - PROCESS | 32036 | Cycle 1(1): loaded http://localhost:39543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39543/tests/dromaeo/cssquery-ext.html) 05:49:19 INFO - PROCESS | 32036 | RSS: Main: 269910016 05:49:19 INFO - PROCESS | 32036 | 05:52:21 INFO - PROCESS | 32036 | Cycle 1(1): loaded http://localhost:39543/tests/dromaeo/cssquery-ext.html (next: http://localhost:39543/tests/dromaeo/cssquery-jquery.html) 05:52:22 INFO - PROCESS | 32036 | RSS: Main: 238342144 05:52:22 INFO - PROCESS | 32036 | 05:55:24 INFO - PROCESS | 32036 | Cycle 1(1): loaded http://localhost:39543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39543/tests/dromaeo/cssquery-mootools.html) 05:55:24 INFO - PROCESS | 32036 | RSS: Main: 222384128 05:55:24 INFO - PROCESS | 32036 | 05:58:26 INFO - PROCESS | 32036 | Cycle 1(1): loaded http://localhost:39543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39543/tests/dromaeo/cssquery-prototype.html) 05:58:27 INFO - PROCESS | 32036 | RSS: Main: 212492288 05:58:27 INFO - PROCESS | 32036 | 06:01:29 INFO - PROCESS | 32036 | Cycle 1(1): loaded http://localhost:39543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39543/tests/dromaeo/cssquery-yui.html) 06:01:30 INFO - PROCESS | 32036 | RSS: Main: 217399296 06:01:30 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | Cycle 1(1): loaded http://localhost:39543/tests/dromaeo/cssquery-yui.html (next: http://localhost:39543/tests/dromaeo/cssquery-dojo.html) 06:04:32 INFO - PROCESS | 32036 | RSS: Main: 253943808 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | __start_tp_report 06:04:32 INFO - PROCESS | 32036 | _x_x_mozilla_page_load 06:04:32 INFO - PROCESS | 32036 | _x_x_mozilla_page_load_details 06:04:32 INFO - PROCESS | 32036 | |i|pagename|runs| 06:04:32 INFO - PROCESS | 32036 | |0;dojo.html;3158.9210269743267;3160.620725512938;3206.310643211709;3211.807291562505;3239.4978778289365;5127.564157046646;5215.1655735082395;5276.6042546809;5287.180487024512;5287.4976877196705;5224.216367544861;5251.632385733;5289.894202115965;5324.227986941891;5330.093884039713;4749.548792864681;4821.30091136785;4826.34844296019;4850.587700045483;4883.312696115727;4933.407991041062;4940.555350018498;4975.154223781966;4976.751162441863;4999.175136102557;4703.694259873131;4788.80844766209;4809.278608208761;4912.042151780404;4913.361263035818;4785.21044027735;4798.760061996886;4828.299896515021;4842.903141937141;4856.4415092264135;4745.288206768978;4768.403949506312;4781.474037855833;4790.520947905216;4795.6163506919365;4975.925361119586;5029.245613158019;5094.745262736848;5121.871953201163;5173;5696.401877802854;5779.219805326269;5783.88432231353;5784.710764461802;5789.971050144764;5778.162166485836;5792.189093526909;5801.970990145022;5810.970945145247;5812.970935145339;5230.947690523122;5291.126964050965;5316.73416329182;5321.680699158062;5323.441038690882;5840.737166827503;5899.46904778572;5902.793402230901;5944.940550594525;5945.583809133319;5693.544516438675;5694.373618901917;5694.373618901917;5705.686187259741;5708.743106560215;5502.394736578973;5520;5682.40334764852;5775.624584402084;5800;5613.635113717677;5636.85907852307;5673.773049078073;5689.288838895138;5695.686737229409;5682.460166284196;5684.062129748628;5687.317521897398;5693.060644993529;5699.886002279931;4280.743155410623;4343.913121737548;4356.302991521341;4356.607905288476;4453.755043472575;3950.525936887592;3959.7822119783687;3968.3849003404516;3972.741771784825;4003.499562554681;5471.343438787371;5485.533729633026;5488.69812160327;5504.834854954358;5506.862328441821;5476.726163691799;5580.9441905580425;5586.972065139648;5713;5725.5133313667975;5397.163439666858;5397.271368365299;5422.132458806572;5474.562035037187;5484.7531861066345;4993.950060499421;5000.000000000015;5011.824586139468;5021.5229553192385;5046.142155833517;5717.199592057115;5828.242328497268;5846.503047241032;5877.764889404376;5908.20239267702;5670.092785154356;5675.205471233948;5676.602637815478;5701.657900525982;5748.109043098327;5874.765009399747;5875.882482350244;5891.440313170242;5893.174955506318;5903.822885313448;5448.591355648421;5512.889742205053;5522.088855338824;5531.529819965187;5621.213030175861;5714.885702286014;5748.39641837601;5751.252337196138;5754.050581654147;5804.042333015005;5592.972035139798;5614.2701448811395;5614.550835933197;5615.6630602164005;5624.57815663835;5360.812371566976;5423.972880135574;5445.945540544702;5534.4742249486235;5559.16612508127;5456.972715136399;5480;5486.6982315973;5487.2317875496665;5489.670619762827;5597.496225339576;5600.8879822402505;5607.43925607436;5618.943810562006;5668.801591944262;5343.198520221998;5411.594130440311;5414.783408663609;5432.674039557639;5517.641353312182 06:04:32 INFO - PROCESS | 32036 | |1;ext.html;554.3253653171835;587.20727018525;587.6826513682611;596.1504855580796;600.1447936690216;28863;29734.702652973465;29748.553771693416;29749.85125074377;35689;42689.14621707564;43135.56864431355;43154.56845431553;43235;43378.34932476008;8510.957445212765;8839.60221790021;8847;8847.601857916408;8859.158379953895;7680.615969201545;7884.408669349822;7902.130765615778;7902.288794008538;8557.914420855805;10045.899541004606;10315.277930544866;10375.481225938673;10417.843732344021;10439.478026098703;10288.89711102887;10332.173426125892;10380.948095259551;10409.063184313372;10415.739606509822;7612.695492180306;7783.688652453895;10075.89924100757;10197.439140847251;10494.68515944523;39820.402693959615;40217.79891100555;40289.79855100706;40326.798366007984;40340.39489407661;3216.7426605871474;3379.898603041913;3466.861325546975;3837.0982819037504;3846.7114966377635;28260;29445.909763017862;29462.26344341387;30412.239694007607;30568;3771.5662698789715;3772.5661548921953;3797.544294684628;3830.3488406970882;3918.0792513759243;259926;260248;260671;260724;262760;58796.706016470496;59004;59123.704381477815;59152.11271830926;59211;61061.38938610557;61513.38486615166;61704;61763.6911815447;61802.69098654568;13541.526046588519;13811.654708632364;13894.4442222312;13946;13950.720985580232;10441.738956526147;10501.789964200672;10505.737356565995;10524.526396312185;10528;19501.609967800563;19845.503862403555;19933.501662458555;19956.50108747264;19974.201031958848;7493.213212612706;7725.150233474314;7857.764267071997;7862.646180921873;7890.64492097857;882.2060145868642;888.6312180445043;904.8054668246227;1013.1185868294631;1043.7077618266746;28159.577606335923;28467.28831779222;28651.126519063542;28818.567721484196;31201.531977020364;917.2707697380598;930;980.3970558106855;1006.9848952265722;1058.2380685906135;13866;13964.090054784676;14172.64568385778;14188.645283867985;14216.857831421554;304438;314125;316240;316907;320237;38483;50000;50977.23534146991;50992;51141.23288150681;1263.8988880889506;1330.900182486298;1353.2895230004326;1354.512375544803;1362.9114107583173;25043.749562504872;25546.136208094023;25897.48205035851;28845.711542884303;29317.706822931497;48424.27363589619;49590.75204623954;49651;49685;49706.00587988148;202044;202544;203659;204392;205046;29234;29294;29294;29680.851595741882;29705.85147074251;40499;41809.02814232643;42186;42356.15287694167;43655.563444366424;36072.098197545274;36515;36698.8165059173;37995.2400951985;38195;36604.63395366012;37326.25347492981;37466.438003430514;37547.81226093852;37665.62334376731;35526.46710299296;36005.27989440249;36420.63579364278;36644.26711465809;36674;29043.27391815137;31609;31883.840580797874;32285.677143228266;32331.35337293288;24241.63637545403;24464;24488.387790305384;24913.750862491866;25080 06:04:32 INFO - PROCESS | 32036 | |2;jquery.html;353.5680493999302;354.07586200017965;357.12682491308755;359.4015963420903;361.2900650222313;13911.721765564682;14163.572674258825;16341.509754707364;16705.16474176291;17490.12549372531;13465.730685386286;13834.23911684857;16535.090570018645;16579.336826526924;17114.486565403025;5279.3928698199625;5338.866528336784;5421.457854214586;5432.239486471897;5435.402105768362;3730.123420996064;3836.5779764225913;5112.667676601028;5246.134387826004;5390.1914712793005;5357.276767636377;5441.428649991753;5472.097103977839;5478.315210598676;5481.862953426176;5019.222020586815;5112.872178195537;5429.809956651518;5432.565394768429;5438.564914806806;4884.535969082932;4894.388201474816;4911.140550403665;4912.606991440676;4916.360873086476;15623.296951637203;19921;19972.700409493867;19993.300234491722;20798.688019679717;1966.3805901141238;1981.9405417837488;1999.8200161985492;2103.4846462616606;2148.688440176166;9372.765680858032;9487.620495180254;10219.926907674662;10299.691009269734;13258;1690.1464760295971;1712.6660301241263;1732.4109802667028;1748;1751.4570483150264;59158.704206479124;62068;63355;63446.36553634497;64191.999999999534;9794.510274486247;9837.80324393508;9874.654387096418;9892.653757118467;10028.548715307828;12939.741205175844;13044.347782610832;13050;13059.673508162183;13069.15050521713;6852.109225800714;6950.06174166481;6996.545224560387;7010.474214433938;7038.472114591426;6678.165229346332;6710.899336509956;6733.057371967929;6755.1556055493065;6764.323567643196;4370.431843860341;4453.51011388747;4454.844080457168;4463.642908567307;4480.865574032784;1722.4937715623737;1759.498542915263;1772.7252275897256;1824.297645406528;1826.2603645523584;420.1408120393802;826.98346033079;867.522862425676;916.1754421021134;945.3524335829978;10182.898171018343;10539.683809485728;10557.155427565776;10754.300970436896;10834.07910327631;385.7203527442638;413.70626854933334;421.62054151264107;433.3045462033454;444.2447838674267;5671.376148623648;9707.369021013612;10407;10438.478076096164;10472.16222702182;497930;500934;503483;507732;513683;73296.63351683208;74246.62876685582;75261.24738752651;76432.61783691046;78280.2171978273;1130.6834086455806;1138.5445821671233;1143.5825923537848;1150.8331291962786;1152.4525850221078;13704.931475342559;15385.615359616098;15543.922280388526;15556.611084722972;16000.279987400827;31456.685433146293;31922.20194495156;32040.198995025312;32197.35605287928;33258.67189296726;36612.26775464529;37158;38994.6100538991;39453.408198877616;42299.7885010573;9245.676401325922;9331.16019558243;9476.526173691425;9494.335396522178;9544.379615324982;11132.443377830914;11186.496607652838;11252.381119038204;14929.850701492845;17756.911215444357;11802.940985295361;11988.220765650205;12649.304288263866;14389.352479138255;14481.565553033004;13670.52153174634;13728.794068088788;13795.10331828428;14360.497382591977;14807.481738139113;14292.968011071127;14395.265565943986;14492.782608260673;14550.345234464687;14653.413863445343;9271.721848344561;9278.211352035152;9392.060793920553;9395.577199025924;9477.383970041925;10956.671299861016;13832.446702131801;14216.289185540474;14510.709785804014;14570.198639074953 06:04:32 INFO - PROCESS | 32036 | |3;mootools.html;1356.1049707193254;1714.4085290574749;1755.6400937807744;1780.910954452277;1785.1342099081944;6586.8682626347445;7554.811129721753;7660.770176894702;7669.159401743584;7679.001729775128;7531.887021694679;7673.424493163007;7714;7721.498102623325;7726.690932362699;1921.3371386871577;1952.7363805886166;2118.184498967893;2210.204326442479;2239.305815197294;2223.1218668625884;2226.8886555672234;2230.4535388829677;2233.2741858895843;2241.2155745489113;2153.4723992621753;2229.565234779219;2230.6877037214804;2231.5090680050444;2232.6539386395134;2224.254874617005;2233.184887516053;2242.6523888797265;2253.9661905071275;2272.2842304673973;2231.0964059555904;2243.5064285857084;2257.7855103765114;2263.6265016272296;2276.5333106713083;7550.320471157567;7553.395728341719;7607.6576554054645;7608.277213664693;7613.885791713129;4592.6555508337005;4637.1421287062;4638.1883170445035;4650.232711602582;4680.251159814447;2938.1185644306624;3024.1834704629628;3027.1826606816035;3060.7551395888277;3063.0504543591337;924.2929159193222;941.5245301122958;945.7162851144698;959.5490119643756;1024.1346062577186;10404.115650169744;10409.115225205867;10411.53148108337;10433.9478302608;10441.634542790965;4127.153933443637;4158;4211.789410529523;4225.02824350395;4228.471441069866;8891.91108088911;8909.777255568662;8950.820983580292;8960.596773145224;8969.14793094655;4660.370849935283;4701.95298047022;4702.388689470347;4704.200285951397;4710.36410084641;4241.893952651209;4261.041265715251;4270.316749320094;4282.807273672693;4286.249906266453;3259.3155437357946;3296.7032967033083;3455.6026057003264;3493.7554371193773;3507;1105.4086063955906;1115.59838458155;1125.5779082843933;1126.8253420719802;1128.480898786551;960.8126415349079;1264.4120483974996;1301.563976068009;1306.6014865466125;1342.4026308292716;7191.352778249878;7243.818904527429;7260.528065675714;7263.455240856957;7281.344678978811;1109.6227282723912;1119.770447058351;1135.642272684102;1148.2077366617007;1153.117864833403;5333;5365.7585408656705;5405.270288511001;5421.484958928895;5429.5656347492895;8763.342749293828;8922.643094276156;9053.547322633842;9096.408733432305;9104.772380690536;8520.8721869172;8613.397062205711;8634.136586341316;8636.395452318277;8669.306455483546;7129.3583577478275;7204.17152027513;7207.819804504825;7212.4951253411755;7264.963675181591;7051.682674279567;7215.386692131227;7239.601821899846;7240.275972402928;7241.782746517613;7869.606519673879;8131.471454355448;8131.634076466455;8226.506409615204;8269.503829770232;7916.168802275678;8158.980127484065;8168.754937351889;8169.428140030141;8296.792580185302;6884.827879302858;6940.895886561807;6947.930520694728;6960.617166055713;6966.4775141865575;7132.964335178291;7258.3104605062435;7260.782176534713;7271.527350722186;7275.854482910418;6737.730490780314;6905.274946130584;6935.618540980295;6946.513744038071;6985.301469852974;6635.303293154342;6826.453883689393;6891.069705589882;6907.965460172868;6919.481038922;6944.236134025152;6978.47661425385;6981.5461994970165;6993.020977063114;6996.055532503047;6231.034189700604;6233.594816336924;6238.376162383725;6248.718807653758;6252.812415627538;6135.07973803933;6170.938290617216;6172.629642221481;6175.505959523138;6187.102870083722 06:04:32 INFO - PROCESS | 32036 | |4;prototype.html;339.58909719239716;342.0542200814747;344.70699905080687;345.571491350725;348.88138033068753;5772.509336706385;5881.588288819784;5887.793002434501;5901.114832775086;5966.284045914496;5745.2818397700285;5836.2996440427205;5855.76576936922;5859.121131830228;5882.647041177522;4562.133194692998;4565.657575681837;4573.611243044345;4576.039031803325;4582.816687332503;4372.650187984969;4442.511323754385;4454.53227411122;4548.567886050836;4581.816727330903;4495.865124046284;4512.345709872066;4514.413126293577;4525.524819893913;4537.523560026199;4506.278995360743;4546.204414227497;4548.226801443762;4555.2256116460285;4560;4035.3341698619693;4035.757854528738;4037.454943582608;4039.0104424415913;4052.230076285496;5463.371712253102;5578.581606379497;5579.163125531162;5602.551795856321;5604.551635869121;5315.468453154692;5317.548008419289;5318.627696061278;5320.547753440924;5337.492938170868;5904.2029326040865;6256.71844766982;6273.302479933626;6274.529410294201;6276.435120839101;4375.2999520076955;4377.124575084996;4426.269665505188;4453.576910193527;4460.955390446086;6341.936580634181;6418.133551970424;6433.420992110732;6438.291787903327;6446.258680251737;4581.702189357681;4582.335561343653;4595.172868883633;4596.839110631112;4600.3099535070005;4568.885777855514;4653.325267836145;4654.650901182357;4657.510961349009;4674.626029917598;5287.629865909349;5302.522772950453;5305.840824775263;5307.28351672527;5309.044372012998;6276.274024643169;6276.843078923063;6281.340459251713;6289.811305660837;6290.025046117859;1632.7224371856812;1640.9169947834373;1641.1384023387816;1643.1866226218099;1643.7452194909808;1097.868255809308;1114.804909140897;1120.3725913488472;1132.6092498088146;1165.1494409081417;6092.817215483543;6109.6639684817765;6116.785912493041;6120.816375508742;6122.295935967331;6426.839329016719;6444.806655800334;6446.903296450463;6448.613083215022;6451.419372256426;5940.8811823764145;6074;6081.391860813883;6085.056816193497;6085.908711369333;3472.079898826813;3492.2840817632323;3493.2489514754448;3493.825308734553;3494.178867966026;6650.301718319603;6662.933370666328;6669.066330713704;6676.632785196861;6678.565893216925;6465.4827613790785;6565.310642382577;6571.047198156336;6572.638504882182;6579.736810527621;6600.075989361493;6652.900206496906;6654.534182607268;6675.032120342523;6682.198136223684;6291.779787707408;6416.32628573993;6434.2922278548385;6441.67791610427;6448.871022579428;6257.374262573706;6347.206599175103;6443.903341449975;6448.032795080775;6451.096846441408;6739.5619284746335;6758.831029224112;6766.763163289262;6767.796966091025;6771.153605799275;4537.546245375568;4592.977035114803;4616.007558374966;4620.676552641417;4620.907581848277;6489.059086432535;6491.448226900767;6497.8700425992165;6505.8698826024165;6512.967435162794;6331.778387756406;6334.651594162366;6337.683115844097;6340.4293613575;6343.619382837044;6196.504279657706;6313.779017734358;6315.747370105328;6323;6328.208973878265;6165.506759459322;6179.227596550431;6183.96908015475;6198.845028874314;6207.224096987877;6324.335944725737;6324.430801227912;6325.810225693236;6327.936720632735;6330.575620485354;6041.426064523863;6160.44555989963;6165.167702360124;6166.475849552839;6171.567990240819 06:04:32 INFO - PROCESS | 32036 | |5;yui.html;740.5889731199183;773.4237992695442;840.3613253927017;850.6852464588102;862.7325529085982;12652.92450141738;13207.471701131943;13208.669783255411;13221.20672759635;13239.139455935358;12345;12396.690082747937;12608.36958152091;12650;12705.491780328799;838.1785849867134;848.2026894718975;849.2144766091341;849.8682704180862;850.2390360627235;681.8431760695019;681.8977153427;826.2811354121892;832.4505826154739;847.3517758914404;881.6120906800987;883.2668884825612;889.3463304471209;892.3084609427713;893.2809088683607;710.3784188834769;876.3821505838368;878.3544095090103;880.4585180114216;881.3566096749377;533.4265664410735;631.3150231998287;641.4868105515569;641.9101325814343;642.8071578526424;12837;12934.741305173844;12937.547185848543;12941.223526588436;12979.41592628334;11037.83443248352;12294.569690060805;12333.444994975158;12508.186967847152;12553.74892502154;9358.859617105749;9410.90589094107;9656.951715241448;9735.56189971453;10014.449205293706;3612.224149273388;3674.577423596294;3704.573973992998;3713.832877520518;3720.5907350191455;46846.29730554044;46888;46910.76544617289;47066;47201.52798472006;9335.579898904565;9576.138147566753;9797.461139637246;9831.066048725359;9895.950520247352;16486.258118384703;16568.75146872798;16621.66756664884;16625.50123496297;16664.83335166657;7176.210616832144;7315.890261646079;7316.817079572947;7435.144958329862;7505.061867266591;4099.733517321424;4182.644475219579;4209.684273679486;4244.72409293395;4353.956460435418;3006.7744919130714;3026.546018097303;3026.9091927242216;3033.605631267921;3036.4382589221063;519.3637793702684;532.7522701943615;535.3682654467765;536.6779932040745;537.2424880917887;640.2732898160622;666.8132922781629;676.4182802789597;682.375626301938;692.1313751242159;7949.284564389232;8625.654973800978;8744.213020828156;8919;8951.910480895238;653.5915053091818;654.3914159831307;660.9471242300605;671.8479794867667;672.488908429597;3753.343164946178;3846.7307288490097;3848.4804551385764;3959.8416063357718;3974.364101743707;53180.73409632927;53598.7320063405;53661.46338536643;53786.731066344415;56069;48961.75519122381;50289.497105029215;50745.49254507481;51278.74360628173;51373;47090.5290947093;47158.528414716784;47570.762146189045;47602.285965710544;48042.27936580954;8470.560004799076;8540.70107546233;8671.956640216758;8765.824683506422;8827.823443531222;35202;35869;36353;36553;36573;42859.571404286806;43171.78414107909;47334.76332618315;47553.28670069882;47702.76148619235;10885.727856803644;11112.833307500556;11114.610988615359;11501.482433290355;11847.585334513251;11869.10981676395;12219.816702749644;12249.654139662987;12562.497500100259;12592.496300148257;11186.105111591216;11471.885281147415;11923.10576706733;11927.403629818647;11991.160618756952;11386.316820990767;11608.187426880037;11791.587294444653;12023.338716370683;12026.27842329463;10389.740256493647;10521.368717876952;10683;10684.679459616224;10927.836082458929;9089.681861134828;9341.953290233505;9450.43297402158;9612.567434465325;9792.853107203255;9011.504367259864;9523;9534;9588.856167157637;10098.669755922112 06:04:32 INFO - PROCESS | 32036 | __end_tp_report 06:04:32 INFO - PROCESS | 32036 | __start_cc_report 06:04:32 INFO - PROCESS | 32036 | _x_x_mozilla_cycle_collect,933 06:04:32 INFO - PROCESS | 32036 | __end_cc_report 06:04:32 INFO - PROCESS | 32036 | __startTimestamp1450793072931__endTimestamp 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | ------- Summary: start ------- 06:04:32 INFO - PROCESS | 32036 | Number of tests: 6 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | [#0] dojo.html Cycles:165 Average:5293.20 Median:5485.53 stddev:585.22 (10.7%) stddev-sans-first:562.55 06:04:32 INFO - PROCESS | 32036 | Values: 3158.9 3160.6 3206.3 3211.8 3239.5 5127.6 5215.2 5276.6 5287.2 5287.5 5224.2 5251.6 5289.9 5324.2 5330.1 4749.5 4821.3 4826.3 4850.6 4883.3 4933.4 4940.6 4975.2 4976.8 4999.2 4703.7 4788.8 4809.3 4912.0 4913.4 4785.2 4798.8 4828.3 4842.9 4856.4 4745.3 4768.4 4781.5 4790.5 4795.6 4975.9 5029.2 5094.7 5121.9 5173.0 5696.4 5779.2 5783.9 5784.7 5790.0 5778.2 5792.2 5802.0 5811.0 5813.0 5230.9 5291.1 5316.7 5321.7 5323.4 5840.7 5899.5 5902.8 5944.9 5945.6 5693.5 5694.4 5694.4 5705.7 5708.7 5502.4 5520.0 5682.4 5775.6 5800.0 5613.6 5636.9 5673.8 5689.3 5695.7 5682.5 5684.1 5687.3 5693.1 5699.9 4280.7 4343.9 4356.3 4356.6 4453.8 3950.5 3959.8 3968.4 3972.7 4003.5 5471.3 5485.5 5488.7 5504.8 5506.9 5476.7 5580.9 5587.0 5713.0 5725.5 5397.2 5397.3 5422.1 5474.6 5484.8 4994.0 5000.0 5011.8 5021.5 5046.1 5717.2 5828.2 5846.5 5877.8 5908.2 5670.1 5675.2 5676.6 5701.7 5748.1 5874.8 5875.9 5891.4 5893.2 5903.8 5448.6 5512.9 5522.1 5531.5 5621.2 5714.9 5748.4 5751.3 5754.1 5804.0 5593.0 5614.3 5614.6 5615.7 5624.6 5360.8 5424.0 5445.9 5534.5 5559.2 5457.0 5480.0 5486.7 5487.2 5489.7 5597.5 5600.9 5607.4 5618.9 5668.8 5343.2 5411.6 5414.8 5432.7 5517.6 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | [#1] ext.html Cycles:180 Average:43306.63 Median:32308.52 stddev:68816.98 (213.0%) stddev-sans-first:68935.16 06:04:32 INFO - PROCESS | 32036 | Values: 554.3 587.2 587.7 596.2 600.1 28863.0 29734.7 29748.6 29749.9 35689.0 42689.1 43135.6 43154.6 43235.0 43378.3 8511.0 8839.6 8847.0 8847.6 8859.2 7680.6 7884.4 7902.1 7902.3 8557.9 10045.9 10315.3 10375.5 10417.8 10439.5 10288.9 10332.2 10380.9 10409.1 10415.7 7612.7 7783.7 10075.9 10197.4 10494.7 39820.4 40217.8 40289.8 40326.8 40340.4 3216.7 3379.9 3466.9 3837.1 3846.7 28260.0 29445.9 29462.3 30412.2 30568.0 3771.6 3772.6 3797.5 3830.3 3918.1 259926.0 260248.0 260671.0 260724.0 262760.0 58796.7 59004.0 59123.7 59152.1 59211.0 61061.4 61513.4 61704.0 61763.7 61802.7 13541.5 13811.7 13894.4 13946.0 13950.7 10441.7 10501.8 10505.7 10524.5 10528.0 19501.6 19845.5 19933.5 19956.5 19974.2 7493.2 7725.2 7857.8 7862.6 7890.6 882.2 888.6 904.8 1013.1 1043.7 28159.6 28467.3 28651.1 28818.6 31201.5 917.3 930.0 980.4 1007.0 1058.2 13866.0 13964.1 14172.6 14188.6 14216.9 304438.0 314125.0 316240.0 316907.0 320237.0 38483.0 50000.0 50977.2 50992.0 51141.2 1263.9 1330.9 1353.3 1354.5 1362.9 25043.7 25546.1 25897.5 28845.7 29317.7 48424.3 49590.8 49651.0 49685.0 49706.0 202044.0 202544.0 203659.0 204392.0 205046.0 29234.0 29294.0 29294.0 29680.9 29705.9 40499.0 41809.0 42186.0 42356.2 43655.6 36072.1 36515.0 36698.8 37995.2 38195.0 36604.6 37326.3 37466.4 37547.8 37665.6 35526.5 36005.3 36420.6 36644.3 36674.0 29043.3 31609.0 31883.8 32285.7 32331.4 24241.6 24464.0 24488.4 24913.8 25080.0 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | [#2] jquery.html Cycles:180 Average:27005.96 Median:360.35 stddev:82519.10 (22900.0%) stddev-sans-first:82726.32 06:04:32 INFO - PROCESS | 32036 | Values: 353.6 354.1 357.1 359.4 361.3 13911.7 14163.6 16341.5 16705.2 17490.1 13465.7 13834.2 16535.1 16579.3 17114.5 5279.4 5338.9 5421.5 5432.2 5435.4 3730.1 3836.6 5112.7 5246.1 5390.2 5357.3 5441.4 5472.1 5478.3 5481.9 5019.2 5112.9 5429.8 5432.6 5438.6 4884.5 4894.4 4911.1 4912.6 4916.4 15623.3 19921.0 19972.7 19993.3 20798.7 1966.4 1981.9 1999.8 2103.5 2148.7 9372.8 9487.6 10219.9 10299.7 13258.0 1690.1 1712.7 1732.4 1748.0 1751.5 59158.7 62068.0 63355.0 63446.4 64192.0 9794.5 9837.8 9874.7 9892.7 10028.5 12939.7 13044.3 13050.0 13059.7 13069.2 6852.1 6950.1 6996.5 7010.5 7038.5 6678.2 6710.9 6733.1 6755.2 6764.3 4370.4 4453.5 4454.8 4463.6 4480.9 1722.5 1759.5 1772.7 1824.3 1826.3 420.1 827.0 867.5 916.2 945.4 10182.9 10539.7 10557.2 10754.3 10834.1 385.7 413.7 421.6 433.3 444.2 5671.4 9707.4 10407.0 10438.5 10472.2 497930.0 500934.0 503483.0 507732.0 513683.0 73296.6 74246.6 75261.2 76432.6 78280.2 1130.7 1138.5 1143.6 1150.8 1152.5 13704.9 15385.6 15543.9 15556.6 16000.3 31456.7 31922.2 32040.2 32197.4 33258.7 36612.3 37158.0 38994.6 39453.4 42299.8 9245.7 9331.2 9476.5 9494.3 9544.4 11132.4 11186.5 11252.4 14929.9 17756.9 11802.9 11988.2 12649.3 14389.4 14481.6 13670.5 13728.8 13795.1 14360.5 14807.5 14293.0 14395.3 14492.8 14550.3 14653.4 9271.7 9278.2 9392.1 9395.6 9477.4 10956.7 13832.4 14216.3 14510.7 14570.2 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | [#3] mootools.html Cycles:180 Average:5323.46 Median:6232.31 stddev:2724.52 (43.7%) stddev-sans-first:2715.84 06:04:32 INFO - PROCESS | 32036 | Values: 1356.1 1714.4 1755.6 1780.9 1785.1 6586.9 7554.8 7660.8 7669.2 7679.0 7531.9 7673.4 7714.0 7721.5 7726.7 1921.3 1952.7 2118.2 2210.2 2239.3 2223.1 2226.9 2230.5 2233.3 2241.2 2153.5 2229.6 2230.7 2231.5 2232.7 2224.3 2233.2 2242.7 2254.0 2272.3 2231.1 2243.5 2257.8 2263.6 2276.5 7550.3 7553.4 7607.7 7608.3 7613.9 4592.7 4637.1 4638.2 4650.2 4680.3 2938.1 3024.2 3027.2 3060.8 3063.1 924.3 941.5 945.7 959.5 1024.1 10404.1 10409.1 10411.5 10433.9 10441.6 4127.2 4158.0 4211.8 4225.0 4228.5 8891.9 8909.8 8950.8 8960.6 8969.1 4660.4 4702.0 4702.4 4704.2 4710.4 4241.9 4261.0 4270.3 4282.8 4286.2 3259.3 3296.7 3455.6 3493.8 3507.0 1105.4 1115.6 1125.6 1126.8 1128.5 960.8 1264.4 1301.6 1306.6 1342.4 7191.4 7243.8 7260.5 7263.5 7281.3 1109.6 1119.8 1135.6 1148.2 1153.1 5333.0 5365.8 5405.3 5421.5 5429.6 8763.3 8922.6 9053.5 9096.4 9104.8 8520.9 8613.4 8634.1 8636.4 8669.3 7129.4 7204.2 7207.8 7212.5 7265.0 7051.7 7215.4 7239.6 7240.3 7241.8 7869.6 8131.5 8131.6 8226.5 8269.5 7916.2 8159.0 8168.8 8169.4 8296.8 6884.8 6940.9 6947.9 6960.6 6966.5 7133.0 7258.3 7260.8 7271.5 7275.9 6737.7 6905.3 6935.6 6946.5 6985.3 6635.3 6826.5 6891.1 6908.0 6919.5 6944.2 6978.5 6981.5 6993.0 6996.1 6231.0 6233.6 6238.4 6248.7 6252.8 6135.1 6170.9 6172.6 6175.5 6187.1 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | [#4] prototype.html Cycles:180 Average:5267.49 Median:5953.58 stddev:1558.66 (26.2%) stddev-sans-first:1518.51 06:04:32 INFO - PROCESS | 32036 | Values: 339.6 342.1 344.7 345.6 348.9 5772.5 5881.6 5887.8 5901.1 5966.3 5745.3 5836.3 5855.8 5859.1 5882.6 4562.1 4565.7 4573.6 4576.0 4582.8 4372.7 4442.5 4454.5 4548.6 4581.8 4495.9 4512.3 4514.4 4525.5 4537.5 4506.3 4546.2 4548.2 4555.2 4560.0 4035.3 4035.8 4037.5 4039.0 4052.2 5463.4 5578.6 5579.2 5602.6 5604.6 5315.5 5317.5 5318.6 5320.5 5337.5 5904.2 6256.7 6273.3 6274.5 6276.4 4375.3 4377.1 4426.3 4453.6 4461.0 6341.9 6418.1 6433.4 6438.3 6446.3 4581.7 4582.3 4595.2 4596.8 4600.3 4568.9 4653.3 4654.7 4657.5 4674.6 5287.6 5302.5 5305.8 5307.3 5309.0 6276.3 6276.8 6281.3 6289.8 6290.0 1632.7 1640.9 1641.1 1643.2 1643.7 1097.9 1114.8 1120.4 1132.6 1165.1 6092.8 6109.7 6116.8 6120.8 6122.3 6426.8 6444.8 6446.9 6448.6 6451.4 5940.9 6074.0 6081.4 6085.1 6085.9 3472.1 3492.3 3493.2 3493.8 3494.2 6650.3 6662.9 6669.1 6676.6 6678.6 6465.5 6565.3 6571.0 6572.6 6579.7 6600.1 6652.9 6654.5 6675.0 6682.2 6291.8 6416.3 6434.3 6441.7 6448.9 6257.4 6347.2 6443.9 6448.0 6451.1 6739.6 6758.8 6766.8 6767.8 6771.2 4537.5 4593.0 4616.0 4620.7 4620.9 6489.1 6491.4 6497.9 6505.9 6513.0 6331.8 6334.7 6337.7 6340.4 6343.6 6196.5 6313.8 6315.7 6323.0 6328.2 6165.5 6179.2 6184.0 6198.8 6207.2 6324.3 6324.4 6325.8 6327.9 6330.6 6041.4 6160.4 6165.2 6166.5 6171.6 06:04:32 INFO - PROCESS | 32036 | 06:04:32 INFO - PROCESS | 32036 | [#5] yui.html Cycles:180 Average:13620.65 Median:47872.52 stddev:15750.04 (32.9%) stddev-sans-first:15764.52 06:04:32 INFO - PROCESS | 32036 | Values: 740.6 773.4 840.4 850.7 862.7 12652.9 13207.5 13208.7 13221.2 13239.1 12345.0 12396.7 12608.4 12650.0 12705.5 838.2 848.2 849.2 849.9 850.2 681.8 681.9 826.3 832.5 847.4 881.6 883.3 889.3 892.3 893.3 710.4 876.4 878.4 880.5 881.4 533.4 631.3 641.5 641.9 642.8 12837.0 12934.7 12937.5 12941.2 12979.4 11037.8 12294.6 12333.4 12508.2 12553.7 9358.9 9410.9 9657.0 9735.6 10014.4 3612.2 3674.6 3704.6 3713.8 3720.6 46846.3 46888.0 46910.8 47066.0 47201.5 9335.6 9576.1 9797.5 9831.1 9896.0 16486.3 16568.8 16621.7 16625.5 16664.8 7176.2 7315.9 7316.8 7435.1 7505.1 4099.7 4182.6 4209.7 4244.7 4354.0 3006.8 3026.5 3026.9 3033.6 3036.4 519.4 532.8 535.4 536.7 537.2 640.3 666.8 676.4 682.4 692.1 7949.3 8625.7 8744.2 8919.0 8951.9 653.6 654.4 660.9 671.8 672.5 3753.3 3846.7 3848.5 3959.8 3974.4 53180.7 53598.7 53661.5 53786.7 56069.0 48961.8 50289.5 50745.5 51278.7 51373.0 47090.5 47158.5 47570.8 47602.3 48042.3 8470.6 8540.7 8672.0 8765.8 8827.8 35202.0 35869.0 36353.0 36553.0 36573.0 42859.6 43171.8 47334.8 47553.3 47702.8 10885.7 11112.8 11114.6 11501.5 11847.6 11869.1 12219.8 12249.7 12562.5 12592.5 11186.1 11471.9 11923.1 11927.4 11991.2 11386.3 11608.2 11791.6 12023.3 12026.3 10389.7 10521.4 10683.0 10684.7 10927.8 9089.7 9342.0 9450.4 9612.6 9792.9 9011.5 9523.0 9534.0 9588.9 10098.7 06:04:32 INFO - PROCESS | 32036 | -------- Summary: end -------- 06:04:32 INFO - PROCESS | 32036 | 06:04:33 INFO - TEST-INFO | 32036: exit 0 06:04:33 INFO - TEST-OK | dromaeo_css | took 1112676ms 06:04:33 INFO - TEST-START | kraken 06:04:33 INFO - operating with platform_type : linux_ 06:04:33 INFO - Initialising browser for kraken test... 06:04:33 INFO - TEST-INFO | started process 32227 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRGuJQb/profile http://localhost:39543/getInfo.html) 06:04:37 INFO - PROCESS | 32227 | __metrics Screen width/height:1600/1200 06:04:37 INFO - PROCESS | 32227 | colorDepth:24 06:04:37 INFO - PROCESS | 32227 | Browser inner width/height: 1024/697 06:04:37 INFO - PROCESS | 32227 | __metrics 06:04:37 INFO - PROCESS | 32227 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:04:37 INFO - PROCESS | 32227 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:04:38 INFO - TEST-INFO | 32227: exit 0 06:04:38 INFO - Browser initialized. 06:04:38 INFO - Running cycle 1/1 for kraken test... 06:04:38 INFO - TEST-INFO | started process 32311 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRGuJQb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:50 INFO - PROCESS | 32311 | RSS: Main: 150302720 06:04:50 INFO - PROCESS | 32311 | 06:04:52 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39543/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:53 INFO - PROCESS | 32311 | RSS: Main: 186339328 06:04:53 INFO - PROCESS | 32311 | 06:04:56 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39543/tests/kraken/driver.html?testName=audio-dft) 06:04:56 INFO - PROCESS | 32311 | RSS: Main: 175833088 06:04:56 INFO - PROCESS | 32311 | 06:04:59 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39543/tests/kraken/driver.html?testName=audio-fft) 06:05:00 INFO - PROCESS | 32311 | RSS: Main: 160264192 06:05:00 INFO - PROCESS | 32311 | 06:05:02 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39543/tests/kraken/driver.html?testName=audio-oscillator) 06:05:02 INFO - PROCESS | 32311 | RSS: Main: 163000320 06:05:02 INFO - PROCESS | 32311 | 06:05:04 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:05 INFO - PROCESS | 32311 | RSS: Main: 164974592 06:05:05 INFO - PROCESS | 32311 | 06:05:08 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39543/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:08 INFO - PROCESS | 32311 | RSS: Main: 163823616 06:05:08 INFO - PROCESS | 32311 | 06:05:12 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39543/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:12 INFO - PROCESS | 32311 | RSS: Main: 166445056 06:05:12 INFO - PROCESS | 32311 | 06:05:15 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39543/tests/kraken/driver.html?testName=json-parse-financial) 06:05:16 INFO - PROCESS | 32311 | RSS: Main: 165797888 06:05:16 INFO - PROCESS | 32311 | 06:05:17 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:18 INFO - PROCESS | 32311 | RSS: Main: 176160768 06:05:18 INFO - PROCESS | 32311 | 06:05:20 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:20 INFO - PROCESS | 32311 | RSS: Main: 174800896 06:05:20 INFO - PROCESS | 32311 | 06:05:22 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:23 INFO - PROCESS | 32311 | RSS: Main: 185573376 06:05:23 INFO - PROCESS | 32311 | 06:05:25 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:26 INFO - PROCESS | 32311 | RSS: Main: 191864832 06:05:26 INFO - PROCESS | 32311 | 06:05:28 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:29 INFO - PROCESS | 32311 | RSS: Main: 189775872 06:05:29 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | Cycle 1(1): loaded http://localhost:39543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39543/tests/kraken/driver.html?testName=ai-astar) 06:05:31 INFO - PROCESS | 32311 | RSS: Main: 247939072 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | __start_tp_report 06:05:31 INFO - PROCESS | 32311 | _x_x_mozilla_page_load 06:05:31 INFO - PROCESS | 32311 | _x_x_mozilla_page_load_details 06:05:31 INFO - PROCESS | 32311 | |i|pagename|runs| 06:05:31 INFO - PROCESS | 32311 | |0;ai-astar;111;111;105;111;111;110;100;110;109;110 06:05:31 INFO - PROCESS | 32311 | |1;audio-beat-detection;151;124;152;161;133;152;150;123;166;124 06:05:31 INFO - PROCESS | 32311 | |2;audio-dft;160;160;160;162;161;161;161;162;161;162 06:05:31 INFO - PROCESS | 32311 | |3;audio-fft;71;72;84;90;71;72;71;115;90;71 06:05:31 INFO - PROCESS | 32311 | |4;audio-oscillator;94;94;138;94;94;94;138;93;94;140 06:05:31 INFO - PROCESS | 32311 | |5;imaging-gaussian-blur;109;110;110;109;109;109;109;109;109;110 06:05:31 INFO - PROCESS | 32311 | |6;imaging-darkroom;146;145;146;145;145;145;145;145;146;145 06:05:31 INFO - PROCESS | 32311 | |7;imaging-desaturate;96;97;96;96;96;95;96;96;97;96 06:05:31 INFO - PROCESS | 32311 | |8;json-parse-financial;59;60;58;58;59;59;58;69;57;57 06:05:31 INFO - PROCESS | 32311 | |9;json-stringify-tinderbox;68;68;67;67;67;67;67;67;74;68 06:05:31 INFO - PROCESS | 32311 | |10;stanford-crypto-aes;83;85;84;84;91;85;84;85;86;84 06:05:31 INFO - PROCESS | 32311 | |11;stanford-crypto-ccm;127;119;114;115;119;126;125;119;120;115 06:05:31 INFO - PROCESS | 32311 | |12;stanford-crypto-pbkdf2;142;142;151;154;154;143;145;150;152;141 06:05:31 INFO - PROCESS | 32311 | |13;stanford-crypto-sha256-iterative;70;68;68;68;71;68;68;67;69;69 06:05:31 INFO - PROCESS | 32311 | __end_tp_report 06:05:31 INFO - PROCESS | 32311 | __start_cc_report 06:05:31 INFO - PROCESS | 32311 | _x_x_mozilla_cycle_collect,956 06:05:31 INFO - PROCESS | 32311 | __end_cc_report 06:05:31 INFO - PROCESS | 32311 | __startTimestamp1450793131288__endTimestamp 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | ------- Summary: start ------- 06:05:31 INFO - PROCESS | 32311 | Number of tests: 14 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.58 (3.2%) stddev-sans-first:3.71 06:05:31 INFO - PROCESS | 32311 | Values: 111.0 111.0 105.0 111.0 111.0 110.0 100.0 110.0 109.0 110.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:151.50 stddev:16.15 (10.7%) stddev-sans-first:16.90 06:05:31 INFO - PROCESS | 32311 | Values: 151.0 124.0 152.0 161.0 133.0 152.0 150.0 123.0 166.0 124.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 06:05:31 INFO - PROCESS | 32311 | Values: 160.0 160.0 160.0 162.0 161.0 161.0 161.0 162.0 161.0 162.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#3] audio-fft Cycles:10 Average:80.70 Median:72.00 stddev:14.48 (20.1%) stddev-sans-first:14.93 06:05:31 INFO - PROCESS | 32311 | Values: 71.0 72.0 84.0 90.0 71.0 72.0 71.0 115.0 90.0 71.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.65 (23.0%) stddev-sans-first:22.43 06:05:31 INFO - PROCESS | 32311 | Values: 94.0 94.0 138.0 94.0 94.0 94.0 138.0 93.0 94.0 140.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:05:31 INFO - PROCESS | 32311 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 06:05:31 INFO - PROCESS | 32311 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:05:31 INFO - PROCESS | 32311 | Values: 96.0 97.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:3.50 (5.9%) stddev-sans-first:3.71 06:05:31 INFO - PROCESS | 32311 | Values: 59.0 60.0 58.0 58.0 59.0 59.0 58.0 69.0 57.0 57.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.50 stddev:2.16 (3.2%) stddev-sans-first:2.29 06:05:31 INFO - PROCESS | 32311 | Values: 68.0 68.0 67.0 67.0 67.0 67.0 67.0 67.0 74.0 68.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.23 (2.6%) stddev-sans-first:2.24 06:05:31 INFO - PROCESS | 32311 | Values: 83.0 85.0 84.0 84.0 91.0 85.0 84.0 85.0 86.0 84.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:119.50 stddev:4.70 (3.9%) stddev-sans-first:4.23 06:05:31 INFO - PROCESS | 32311 | Values: 127.0 119.0 114.0 115.0 119.0 126.0 125.0 119.0 120.0 115.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:150.50 stddev:5.30 (3.5%) stddev-sans-first:5.24 06:05:31 INFO - PROCESS | 32311 | Values: 142.0 142.0 151.0 154.0 154.0 143.0 145.0 150.0 152.0 141.0 06:05:31 INFO - PROCESS | 32311 | 06:05:31 INFO - PROCESS | 32311 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.13 06:05:31 INFO - PROCESS | 32311 | Values: 70.0 68.0 68.0 68.0 71.0 68.0 68.0 67.0 69.0 69.0 06:05:31 INFO - PROCESS | 32311 | -------- Summary: end -------- 06:05:31 INFO - PROCESS | 32311 | 06:05:32 INFO - TEST-INFO | 32311: exit 0 06:05:32 INFO - TEST-OK | kraken | took 58551ms 06:05:32 INFO - TEST-START | v8_7 06:05:32 INFO - operating with platform_type : linux_ 06:05:32 INFO - Initialising browser for v8_7 test... 06:05:32 INFO - TEST-INFO | started process 32559 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvQ_6T/profile http://localhost:39543/getInfo.html) 06:05:36 INFO - PROCESS | 32559 | __metrics Screen width/height:1600/1200 06:05:36 INFO - PROCESS | 32559 | colorDepth:24 06:05:36 INFO - PROCESS | 32559 | Browser inner width/height: 1024/697 06:05:36 INFO - PROCESS | 32559 | __metrics 06:05:36 INFO - PROCESS | 32559 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:05:36 INFO - PROCESS | 32559 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:36 INFO - TEST-INFO | 32559: exit 0 06:05:36 INFO - Browser initialized. 06:05:36 INFO - Running cycle 1/1 for v8_7 test... 06:05:36 INFO - TEST-INFO | started process 32645 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvQ_6T/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:48 INFO - PROCESS | 32645 | RSS: Main: 149889024 06:05:48 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | Cycle 1(1): loaded http://localhost:39543/tests/v8_7/run.html (next: http://localhost:39543/tests/v8_7/run.html) 06:06:10 INFO - PROCESS | 32645 | RSS: Main: 558727168 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | __start_tp_report 06:06:10 INFO - PROCESS | 32645 | _x_x_mozilla_page_load 06:06:10 INFO - PROCESS | 32645 | _x_x_mozilla_page_load_details 06:06:10 INFO - PROCESS | 32645 | |i|pagename|runs| 06:06:10 INFO - PROCESS | 32645 | |0;Richards;166.91704223001167 06:06:10 INFO - PROCESS | 32645 | |1;DeltaBlue;190.69412662090008 06:06:10 INFO - PROCESS | 32645 | |2;Encrypt;280.3476310625175 06:06:10 INFO - PROCESS | 32645 | |3;Decrypt;5164.948453608247 06:06:10 INFO - PROCESS | 32645 | |4;RayTrace;1986.111111111111 06:06:10 INFO - PROCESS | 32645 | |5;Earley;793.6507936507936 06:06:10 INFO - PROCESS | 32645 | |6;Boyer;12518.518518518518 06:06:10 INFO - PROCESS | 32645 | |7;RegExp;26256.410256410258 06:06:10 INFO - PROCESS | 32645 | |8;Splay;581.7335660267597 06:06:10 INFO - PROCESS | 32645 | |9;NavierStokes;4854.368932038835 06:06:10 INFO - PROCESS | 32645 | __end_tp_report 06:06:10 INFO - PROCESS | 32645 | __startTimestamp1450793170415__endTimestamp 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | ------- Summary: start ------- 06:06:10 INFO - PROCESS | 32645 | Number of tests: 10 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 166.9 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#1] DeltaBlue Cycles:1 Average:190.69 Median:190.69 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 190.7 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 280.3 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 5164.9 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 1986.1 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 793.7 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#6] Boyer Cycles:1 Average:12518.52 Median:12518.52 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 12518.5 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 26256.4 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#8] Splay Cycles:1 Average:581.73 Median:581.73 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 581.7 06:06:10 INFO - PROCESS | 32645 | 06:06:10 INFO - PROCESS | 32645 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 06:06:10 INFO - PROCESS | 32645 | Values: 4854.4 06:06:10 INFO - PROCESS | 32645 | -------- Summary: end -------- 06:06:10 INFO - PROCESS | 32645 | 06:06:11 INFO - TEST-INFO | 32645: exit 0 06:06:11 INFO - TEST-OK | v8_7 | took 39036ms 06:06:11 INFO - SUITE-END | took 1210s 06:06:11 INFO - Completed test suite (00:20:10) 06:06:11 INFO - Working with test: dromaeo_css 06:06:11 INFO - Generating results file: dromaeo_css 06:06:11 INFO - Working with test: kraken 06:06:11 INFO - Generating results file: kraken 06:06:11 INFO - javascript benchmark 06:06:11 INFO - Working with test: v8_7 06:06:11 INFO - Generating results file: v8_7 06:06:11 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:06:11 INFO - process_Request line: dromaeo_css 6835.40 graph.html#tests=[[72,1,35]] 06:06:11 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:11 INFO - process_Request line: kraken 1500.50 graph.html#tests=[[232,1,35]] 06:06:11 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:11 INFO - process_Request line: v8_7 19793.63 graph.html#tests=[[230,1,35]] 06:06:11 INFO - RETURN: dromaeo_css: 6835.40 06:06:11 INFO - RETURN: kraken: 1500.50 06:06:11 INFO - RETURN: v8_7: 19793.63 06:06:11 INFO - javascript benchmark 06:06:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3158.9210269743267, 3160.620725512938, 3206.310643211709, 3211.807291562505, 3239.4978778289365, 5127.564157046646, 5215.1655735082395, 5276.6042546809, 5287.180487024512, 5287.4976877196705, 5224.216367544861, 5251.632385733, 5289.894202115965, 5324.227986941891, 5330.093884039713, 4749.548792864681, 4821.30091136785, 4826.34844296019, 4850.587700045483, 4883.312696115727, 4933.407991041062, 4940.555350018498, 4975.154223781966, 4976.751162441863, 4999.175136102557, 4703.694259873131, 4788.80844766209, 4809.278608208761, 4912.042151780404, 4913.361263035818, 4785.21044027735, 4798.760061996886, 4828.299896515021, 4842.903141937141, 4856.4415092264135, 4745.288206768978, 4768.403949506312, 4781.474037855833, 4790.520947905216, 4795.6163506919365, 4975.925361119586, 5029.245613158019, 5094.745262736848, 5121.871953201163, 5173.0, 5696.401877802854, 5779.219805326269, 5783.88432231353, 5784.710764461802, 5789.971050144764, 5778.162166485836, 5792.189093526909, 5801.970990145022, 5810.970945145247, 5812.970935145339, 5230.947690523122, 5291.126964050965, 5316.73416329182, 5321.680699158062, 5323.441038690882, 5840.737166827503, 5899.46904778572, 5902.793402230901, 5944.940550594525, 5945.583809133319, 5693.544516438675, 5694.373618901917, 5694.373618901917, 5705.686187259741, 5708.743106560215, 5502.394736578973, 5520.0, 5682.40334764852, 5775.624584402084, 5800.0, 5613.635113717677, 5636.85907852307, 5673.773049078073, 5689.288838895138, 5695.686737229409, 5682.460166284196, 5684.062129748628, 5687.317521897398, 5693.060644993529, 5699.886002279931, 4280.743155410623, 4343.913121737548, 4356.302991521341, 4356.607905288476, 4453.755043472575, 3950.525936887592, 3959.7822119783687, 3968.3849003404516, 3972.741771784825, 4003.499562554681, 5471.343438787371, 5485.533729633026, 5488.69812160327, 5504.834854954358, 5506.862328441821, 5476.726163691799, 5580.9441905580425, 5586.972065139648, 5713.0, 5725.5133313667975, 5397.163439666858, 5397.271368365299, 5422.132458806572, 5474.562035037187, 5484.7531861066345, 4993.950060499421, 5000.000000000015, 5011.824586139468, 5021.5229553192385, 5046.142155833517, 5717.199592057115, 5828.242328497268, 5846.503047241032, 5877.764889404376, 5908.20239267702, 5670.092785154356, 5675.205471233948, 5676.602637815478, 5701.657900525982, 5748.109043098327, 5874.765009399747, 5875.882482350244, 5891.440313170242, 5893.174955506318, 5903.822885313448, 5448.591355648421, 5512.889742205053, 5522.088855338824, 5531.529819965187, 5621.213030175861, 5714.885702286014, 5748.39641837601, 5751.252337196138, 5754.050581654147, 5804.042333015005, 5592.972035139798, 5614.2701448811395, 5614.550835933197, 5615.6630602164005, 5624.57815663835, 5360.812371566976, 5423.972880135574, 5445.945540544702, 5534.4742249486235, 5559.16612508127, 5456.972715136399, 5480.0, 5486.6982315973, 5487.2317875496665, 5489.670619762827, 5597.496225339576, 5600.8879822402505, 5607.43925607436, 5618.943810562006, 5668.801591944262, 5343.198520221998, 5411.594130440311, 5414.783408663609, 5432.674039557639, 5517.641353312182], "unit": "score", "name": "dojo.html", "value": 5255.5021135580755}, {"lowerIsBetter": false, "replicates": [554.3253653171835, 587.20727018525, 587.6826513682611, 596.1504855580796, 600.1447936690216, 28863.0, 29734.702652973465, 29748.553771693416, 29749.85125074377, 35689.0, 42689.14621707564, 43135.56864431355, 43154.56845431553, 43235.0, 43378.34932476008, 8510.957445212765, 8839.60221790021, 8847.0, 8847.601857916408, 8859.158379953895, 7680.615969201545, 7884.408669349822, 7902.130765615778, 7902.288794008538, 8557.914420855805, 10045.899541004606, 10315.277930544866, 10375.481225938673, 10417.843732344021, 10439.478026098703, 10288.89711102887, 10332.173426125892, 10380.948095259551, 10409.063184313372, 10415.739606509822, 7612.695492180306, 7783.688652453895, 10075.89924100757, 10197.439140847251, 10494.68515944523, 39820.402693959615, 40217.79891100555, 40289.79855100706, 40326.798366007984, 40340.39489407661, 3216.7426605871474, 3379.898603041913, 3466.861325546975, 3837.0982819037504, 3846.7114966377635, 28260.0, 29445.909763017862, 29462.26344341387, 30412.239694007607, 30568.0, 3771.5662698789715, 3772.5661548921953, 3797.544294684628, 3830.3488406970882, 3918.0792513759243, 259926.0, 260248.0, 260671.0, 260724.0, 262760.0, 58796.706016470496, 59004.0, 59123.704381477815, 59152.11271830926, 59211.0, 61061.38938610557, 61513.38486615166, 61704.0, 61763.6911815447, 61802.69098654568, 13541.526046588519, 13811.654708632364, 13894.4442222312, 13946.0, 13950.720985580232, 10441.738956526147, 10501.789964200672, 10505.737356565995, 10524.526396312185, 10528.0, 19501.609967800563, 19845.503862403555, 19933.501662458555, 19956.50108747264, 19974.201031958848, 7493.213212612706, 7725.150233474314, 7857.764267071997, 7862.646180921873, 7890.64492097857, 882.2060145868642, 888.6312180445043, 904.8054668246227, 1013.1185868294631, 1043.7077618266746, 28159.577606335923, 28467.28831779222, 28651.126519063542, 28818.567721484196, 31201.531977020364, 917.2707697380598, 930.0, 980.3970558106855, 1006.9848952265722, 1058.2380685906135, 13866.0, 13964.090054784676, 14172.64568385778, 14188.645283867985, 14216.857831421554, 304438.0, 314125.0, 316240.0, 316907.0, 320237.0, 38483.0, 50000.0, 50977.23534146991, 50992.0, 51141.23288150681, 1263.8988880889506, 1330.900182486298, 1353.2895230004326, 1354.512375544803, 1362.9114107583173, 25043.749562504872, 25546.136208094023, 25897.48205035851, 28845.711542884303, 29317.706822931497, 48424.27363589619, 49590.75204623954, 49651.0, 49685.0, 49706.00587988148, 202044.0, 202544.0, 203659.0, 204392.0, 205046.0, 29234.0, 29294.0, 29294.0, 29680.851595741882, 29705.85147074251, 40499.0, 41809.02814232643, 42186.0, 42356.15287694167, 43655.563444366424, 36072.098197545274, 36515.0, 36698.8165059173, 37995.2400951985, 38195.0, 36604.63395366012, 37326.25347492981, 37466.438003430514, 37547.81226093852, 37665.62334376731, 35526.46710299296, 36005.27989440249, 36420.63579364278, 36644.26711465809, 36674.0, 29043.27391815137, 31609.0, 31883.840580797874, 32285.677143228266, 32331.35337293288, 24241.63637545403, 24464.0, 24488.387790305384, 24913.750862491866, 25080.0], "unit": "score", "name": "ext.html", "value": 18089.816883865813}, {"lowerIsBetter": false, "replicates": [353.5680493999302, 354.07586200017965, 357.12682491308755, 359.4015963420903, 361.2900650222313, 13911.721765564682, 14163.572674258825, 16341.509754707364, 16705.16474176291, 17490.12549372531, 13465.730685386286, 13834.23911684857, 16535.090570018645, 16579.336826526924, 17114.486565403025, 5279.3928698199625, 5338.866528336784, 5421.457854214586, 5432.239486471897, 5435.402105768362, 3730.123420996064, 3836.5779764225913, 5112.667676601028, 5246.134387826004, 5390.1914712793005, 5357.276767636377, 5441.428649991753, 5472.097103977839, 5478.315210598676, 5481.862953426176, 5019.222020586815, 5112.872178195537, 5429.809956651518, 5432.565394768429, 5438.564914806806, 4884.535969082932, 4894.388201474816, 4911.140550403665, 4912.606991440676, 4916.360873086476, 15623.296951637203, 19921.0, 19972.700409493867, 19993.300234491722, 20798.688019679717, 1966.3805901141238, 1981.9405417837488, 1999.8200161985492, 2103.4846462616606, 2148.688440176166, 9372.765680858032, 9487.620495180254, 10219.926907674662, 10299.691009269734, 13258.0, 1690.1464760295971, 1712.6660301241263, 1732.4109802667028, 1748.0, 1751.4570483150264, 59158.704206479124, 62068.0, 63355.0, 63446.36553634497, 64191.999999999534, 9794.510274486247, 9837.80324393508, 9874.654387096418, 9892.653757118467, 10028.548715307828, 12939.741205175844, 13044.347782610832, 13050.0, 13059.673508162183, 13069.15050521713, 6852.109225800714, 6950.06174166481, 6996.545224560387, 7010.474214433938, 7038.472114591426, 6678.165229346332, 6710.899336509956, 6733.057371967929, 6755.1556055493065, 6764.323567643196, 4370.431843860341, 4453.51011388747, 4454.844080457168, 4463.642908567307, 4480.865574032784, 1722.4937715623737, 1759.498542915263, 1772.7252275897256, 1824.297645406528, 1826.2603645523584, 420.1408120393802, 826.98346033079, 867.522862425676, 916.1754421021134, 945.3524335829978, 10182.898171018343, 10539.683809485728, 10557.155427565776, 10754.300970436896, 10834.07910327631, 385.7203527442638, 413.70626854933334, 421.62054151264107, 433.3045462033454, 444.2447838674267, 5671.376148623648, 9707.369021013612, 10407.0, 10438.478076096164, 10472.16222702182, 497930.0, 500934.0, 503483.0, 507732.0, 513683.0, 73296.63351683208, 74246.62876685582, 75261.24738752651, 76432.61783691046, 78280.2171978273, 1130.6834086455806, 1138.5445821671233, 1143.5825923537848, 1150.8331291962786, 1152.4525850221078, 13704.931475342559, 15385.615359616098, 15543.922280388526, 15556.611084722972, 16000.279987400827, 31456.685433146293, 31922.20194495156, 32040.198995025312, 32197.35605287928, 33258.67189296726, 36612.26775464529, 37158.0, 38994.6100538991, 39453.408198877616, 42299.7885010573, 9245.676401325922, 9331.16019558243, 9476.526173691425, 9494.335396522178, 9544.379615324982, 11132.443377830914, 11186.496607652838, 11252.381119038204, 14929.850701492845, 17756.911215444357, 11802.940985295361, 11988.220765650205, 12649.304288263866, 14389.352479138255, 14481.565553033004, 13670.52153174634, 13728.794068088788, 13795.10331828428, 14360.497382591977, 14807.481738139113, 14292.968011071127, 14395.265565943986, 14492.782608260673, 14550.345234464687, 14653.413863445343, 9271.721848344561, 9278.211352035152, 9392.060793920553, 9395.577199025924, 9477.383970041925, 10956.671299861016, 13832.446702131801, 14216.289185540474, 14510.709785804014, 14570.198639074953], "unit": "score", "name": "jquery.html", "value": 8194.038494847451}, {"lowerIsBetter": false, "replicates": [1356.1049707193254, 1714.4085290574749, 1755.6400937807744, 1780.910954452277, 1785.1342099081944, 6586.8682626347445, 7554.811129721753, 7660.770176894702, 7669.159401743584, 7679.001729775128, 7531.887021694679, 7673.424493163007, 7714.0, 7721.498102623325, 7726.690932362699, 1921.3371386871577, 1952.7363805886166, 2118.184498967893, 2210.204326442479, 2239.305815197294, 2223.1218668625884, 2226.8886555672234, 2230.4535388829677, 2233.2741858895843, 2241.2155745489113, 2153.4723992621753, 2229.565234779219, 2230.6877037214804, 2231.5090680050444, 2232.6539386395134, 2224.254874617005, 2233.184887516053, 2242.6523888797265, 2253.9661905071275, 2272.2842304673973, 2231.0964059555904, 2243.5064285857084, 2257.7855103765114, 2263.6265016272296, 2276.5333106713083, 7550.320471157567, 7553.395728341719, 7607.6576554054645, 7608.277213664693, 7613.885791713129, 4592.6555508337005, 4637.1421287062, 4638.1883170445035, 4650.232711602582, 4680.251159814447, 2938.1185644306624, 3024.1834704629628, 3027.1826606816035, 3060.7551395888277, 3063.0504543591337, 924.2929159193222, 941.5245301122958, 945.7162851144698, 959.5490119643756, 1024.1346062577186, 10404.115650169744, 10409.115225205867, 10411.53148108337, 10433.9478302608, 10441.634542790965, 4127.153933443637, 4158.0, 4211.789410529523, 4225.02824350395, 4228.471441069866, 8891.91108088911, 8909.777255568662, 8950.820983580292, 8960.596773145224, 8969.14793094655, 4660.370849935283, 4701.95298047022, 4702.388689470347, 4704.200285951397, 4710.36410084641, 4241.893952651209, 4261.041265715251, 4270.316749320094, 4282.807273672693, 4286.249906266453, 3259.3155437357946, 3296.7032967033083, 3455.6026057003264, 3493.7554371193773, 3507.0, 1105.4086063955906, 1115.59838458155, 1125.5779082843933, 1126.8253420719802, 1128.480898786551, 960.8126415349079, 1264.4120483974996, 1301.563976068009, 1306.6014865466125, 1342.4026308292716, 7191.352778249878, 7243.818904527429, 7260.528065675714, 7263.455240856957, 7281.344678978811, 1109.6227282723912, 1119.770447058351, 1135.642272684102, 1148.2077366617007, 1153.117864833403, 5333.0, 5365.7585408656705, 5405.270288511001, 5421.484958928895, 5429.5656347492895, 8763.342749293828, 8922.643094276156, 9053.547322633842, 9096.408733432305, 9104.772380690536, 8520.8721869172, 8613.397062205711, 8634.136586341316, 8636.395452318277, 8669.306455483546, 7129.3583577478275, 7204.17152027513, 7207.819804504825, 7212.4951253411755, 7264.963675181591, 7051.682674279567, 7215.386692131227, 7239.601821899846, 7240.275972402928, 7241.782746517613, 7869.606519673879, 8131.471454355448, 8131.634076466455, 8226.506409615204, 8269.503829770232, 7916.168802275678, 8158.980127484065, 8168.754937351889, 8169.428140030141, 8296.792580185302, 6884.827879302858, 6940.895886561807, 6947.930520694728, 6960.617166055713, 6966.4775141865575, 7132.964335178291, 7258.3104605062435, 7260.782176534713, 7271.527350722186, 7275.854482910418, 6737.730490780314, 6905.274946130584, 6935.618540980295, 6946.513744038071, 6985.301469852974, 6635.303293154342, 6826.453883689393, 6891.069705589882, 6907.965460172868, 6919.481038922, 6944.236134025152, 6978.47661425385, 6981.5461994970165, 6993.020977063114, 6996.055532503047, 6231.034189700604, 6233.594816336924, 6238.376162383725, 6248.718807653758, 6252.812415627538, 6135.07973803933, 6170.938290617216, 6172.629642221481, 6175.505959523138, 6187.102870083722], "unit": "score", "name": "mootools.html", "value": 4395.858099677847}, {"lowerIsBetter": false, "replicates": [339.58909719239716, 342.0542200814747, 344.70699905080687, 345.571491350725, 348.88138033068753, 5772.509336706385, 5881.588288819784, 5887.793002434501, 5901.114832775086, 5966.284045914496, 5745.2818397700285, 5836.2996440427205, 5855.76576936922, 5859.121131830228, 5882.647041177522, 4562.133194692998, 4565.657575681837, 4573.611243044345, 4576.039031803325, 4582.816687332503, 4372.650187984969, 4442.511323754385, 4454.53227411122, 4548.567886050836, 4581.816727330903, 4495.865124046284, 4512.345709872066, 4514.413126293577, 4525.524819893913, 4537.523560026199, 4506.278995360743, 4546.204414227497, 4548.226801443762, 4555.2256116460285, 4560.0, 4035.3341698619693, 4035.757854528738, 4037.454943582608, 4039.0104424415913, 4052.230076285496, 5463.371712253102, 5578.581606379497, 5579.163125531162, 5602.551795856321, 5604.551635869121, 5315.468453154692, 5317.548008419289, 5318.627696061278, 5320.547753440924, 5337.492938170868, 5904.2029326040865, 6256.71844766982, 6273.302479933626, 6274.529410294201, 6276.435120839101, 4375.2999520076955, 4377.124575084996, 4426.269665505188, 4453.576910193527, 4460.955390446086, 6341.936580634181, 6418.133551970424, 6433.420992110732, 6438.291787903327, 6446.258680251737, 4581.702189357681, 4582.335561343653, 4595.172868883633, 4596.839110631112, 4600.3099535070005, 4568.885777855514, 4653.325267836145, 4654.650901182357, 4657.510961349009, 4674.626029917598, 5287.629865909349, 5302.522772950453, 5305.840824775263, 5307.28351672527, 5309.044372012998, 6276.274024643169, 6276.843078923063, 6281.340459251713, 6289.811305660837, 6290.025046117859, 1632.7224371856812, 1640.9169947834373, 1641.1384023387816, 1643.1866226218099, 1643.7452194909808, 1097.868255809308, 1114.804909140897, 1120.3725913488472, 1132.6092498088146, 1165.1494409081417, 6092.817215483543, 6109.6639684817765, 6116.785912493041, 6120.816375508742, 6122.295935967331, 6426.839329016719, 6444.806655800334, 6446.903296450463, 6448.613083215022, 6451.419372256426, 5940.8811823764145, 6074.0, 6081.391860813883, 6085.056816193497, 6085.908711369333, 3472.079898826813, 3492.2840817632323, 3493.2489514754448, 3493.825308734553, 3494.178867966026, 6650.301718319603, 6662.933370666328, 6669.066330713704, 6676.632785196861, 6678.565893216925, 6465.4827613790785, 6565.310642382577, 6571.047198156336, 6572.638504882182, 6579.736810527621, 6600.075989361493, 6652.900206496906, 6654.534182607268, 6675.032120342523, 6682.198136223684, 6291.779787707408, 6416.32628573993, 6434.2922278548385, 6441.67791610427, 6448.871022579428, 6257.374262573706, 6347.206599175103, 6443.903341449975, 6448.032795080775, 6451.096846441408, 6739.5619284746335, 6758.831029224112, 6766.763163289262, 6767.796966091025, 6771.153605799275, 4537.546245375568, 4592.977035114803, 4616.007558374966, 4620.676552641417, 4620.907581848277, 6489.059086432535, 6491.448226900767, 6497.8700425992165, 6505.8698826024165, 6512.967435162794, 6331.778387756406, 6334.651594162366, 6337.683115844097, 6340.4293613575, 6343.619382837044, 6196.504279657706, 6313.779017734358, 6315.747370105328, 6323.0, 6328.208973878265, 6165.506759459322, 6179.227596550431, 6183.96908015475, 6198.845028874314, 6207.224096987877, 6324.335944725737, 6324.430801227912, 6325.810225693236, 6327.936720632735, 6330.575620485354, 6041.426064523863, 6160.44555989963, 6165.167702360124, 6166.475849552839, 6171.567990240819], "unit": "score", "name": "prototype.html", "value": 4768.088061965445}, {"lowerIsBetter": false, "replicates": [740.5889731199183, 773.4237992695442, 840.3613253927017, 850.6852464588102, 862.7325529085982, 12652.92450141738, 13207.471701131943, 13208.669783255411, 13221.20672759635, 13239.139455935358, 12345.0, 12396.690082747937, 12608.36958152091, 12650.0, 12705.491780328799, 838.1785849867134, 848.2026894718975, 849.2144766091341, 849.8682704180862, 850.2390360627235, 681.8431760695019, 681.8977153427, 826.2811354121892, 832.4505826154739, 847.3517758914404, 881.6120906800987, 883.2668884825612, 889.3463304471209, 892.3084609427713, 893.2809088683607, 710.3784188834769, 876.3821505838368, 878.3544095090103, 880.4585180114216, 881.3566096749377, 533.4265664410735, 631.3150231998287, 641.4868105515569, 641.9101325814343, 642.8071578526424, 12837.0, 12934.741305173844, 12937.547185848543, 12941.223526588436, 12979.41592628334, 11037.83443248352, 12294.569690060805, 12333.444994975158, 12508.186967847152, 12553.74892502154, 9358.859617105749, 9410.90589094107, 9656.951715241448, 9735.56189971453, 10014.449205293706, 3612.224149273388, 3674.577423596294, 3704.573973992998, 3713.832877520518, 3720.5907350191455, 46846.29730554044, 46888.0, 46910.76544617289, 47066.0, 47201.52798472006, 9335.579898904565, 9576.138147566753, 9797.461139637246, 9831.066048725359, 9895.950520247352, 16486.258118384703, 16568.75146872798, 16621.66756664884, 16625.50123496297, 16664.83335166657, 7176.210616832144, 7315.890261646079, 7316.817079572947, 7435.144958329862, 7505.061867266591, 4099.733517321424, 4182.644475219579, 4209.684273679486, 4244.72409293395, 4353.956460435418, 3006.7744919130714, 3026.546018097303, 3026.9091927242216, 3033.605631267921, 3036.4382589221063, 519.3637793702684, 532.7522701943615, 535.3682654467765, 536.6779932040745, 537.2424880917887, 640.2732898160622, 666.8132922781629, 676.4182802789597, 682.375626301938, 692.1313751242159, 7949.284564389232, 8625.654973800978, 8744.213020828156, 8919.0, 8951.910480895238, 653.5915053091818, 654.3914159831307, 660.9471242300605, 671.8479794867667, 672.488908429597, 3753.343164946178, 3846.7307288490097, 3848.4804551385764, 3959.8416063357718, 3974.364101743707, 53180.73409632927, 53598.7320063405, 53661.46338536643, 53786.731066344415, 56069.0, 48961.75519122381, 50289.497105029215, 50745.49254507481, 51278.74360628173, 51373.0, 47090.5290947093, 47158.528414716784, 47570.762146189045, 47602.285965710544, 48042.27936580954, 8470.560004799076, 8540.70107546233, 8671.956640216758, 8765.824683506422, 8827.823443531222, 35202.0, 35869.0, 36353.0, 36553.0, 36573.0, 42859.571404286806, 43171.78414107909, 47334.76332618315, 47553.28670069882, 47702.76148619235, 10885.727856803644, 11112.833307500556, 11114.610988615359, 11501.482433290355, 11847.585334513251, 11869.10981676395, 12219.816702749644, 12249.654139662987, 12562.497500100259, 12592.496300148257, 11186.105111591216, 11471.885281147415, 11923.10576706733, 11927.403629818647, 11991.160618756952, 11386.316820990767, 11608.187426880037, 11791.587294444653, 12023.338716370683, 12026.27842329463, 10389.740256493647, 10521.368717876952, 10683.0, 10684.679459616224, 10927.836082458929, 9089.681861134828, 9341.953290233505, 9450.43297402158, 9612.567434465325, 9792.853107203255, 9011.504367259864, 9523.0, 9534.0, 9588.856167157637, 10098.669755922112], "unit": "score", "name": "yui.html", "value": 6246.123188735192}], "name": "dromaeo_css", "value": 6835.397606320294}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 105.0, 111.0, 111.0, 110.0, 100.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 152.0, 161.0, 133.0, 152.0, 150.0, 123.0, 166.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 84.0, 90.0, 71.0, 72.0, 71.0, 115.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 138.0, 94.0, 94.0, 94.0, 138.0, 93.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 58.0, 58.0, 59.0, 59.0, 58.0, 69.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 74.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 84.0, 91.0, 85.0, 84.0, 85.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [127.0, 119.0, 114.0, 115.0, 119.0, 126.0, 125.0, 119.0, 120.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 151.0, 154.0, 154.0, 143.0, 145.0, 150.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 68.0, 71.0, 68.0, 68.0, 67.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1500.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [190.69412662090008], "unit": "score", "name": "DeltaBlue", "value": 346.72279200000014}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12518.518518518518], "unit": "score", "name": "Boyer", "value": 53.238168639053214}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [581.7335660267597], "unit": "score", "name": "Splay", "value": 140.08302900000007}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19793.626917392452}]} 06:06:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19793.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1500.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6835.40"}}} 06:06:11 INFO - Return code: 0 06:06:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:06:11 INFO - # TBPL SUCCESS # 06:06:11 INFO - Running post-action listener: _resource_record_post_action 06:06:11 INFO - Running post-run listener: _resource_record_post_run 06:06:12 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 562839552; Read time: 164; Write time: 422412 06:06:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234602496; Read time: 0; Write time: 215476 06:06:12 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 312221696; Read time: 164; Write time: 198892 06:06:12 INFO - Running post-run listener: _upload_blobber_files 06:06:12 INFO - Blob upload gear active. 06:06:12 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:06:12 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 06:06:12 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:06:12 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:06:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:13 INFO - (blobuploader) - INFO - Done attempting. 06:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:14 INFO - (blobuploader) - INFO - Done attempting. 06:06:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:14 INFO - Return code: 0 06:06:14 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:06:14 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bcbe276ec45d53588663fd41da4a3fda2d2637da9346c63ae0e0d5857ae0bab7515f233fc8ed7a6d66e50432c34853f01aaa1c7e2f5fa2db51217610c092414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0574cc5f1d1d48276102a99dcfee2faffc46322e00df7f221223ca2c1a49ca373b82a7f076ce63b915143bf6131485d4cb08555fcffe7a22ae6266a81eb05da"} 06:06:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:06:14 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:06:14 INFO - Contents: 06:06:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bcbe276ec45d53588663fd41da4a3fda2d2637da9346c63ae0e0d5857ae0bab7515f233fc8ed7a6d66e50432c34853f01aaa1c7e2f5fa2db51217610c092414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0574cc5f1d1d48276102a99dcfee2faffc46322e00df7f221223ca2c1a49ca373b82a7f076ce63b915143bf6131485d4cb08555fcffe7a22ae6266a81eb05da"} 06:06:14 INFO - Copying logs to upload dir... 06:06:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.111914 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-22 06:06:13.580901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 06:06:13.584820) ========= 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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bcbe276ec45d53588663fd41da4a3fda2d2637da9346c63ae0e0d5857ae0bab7515f233fc8ed7a6d66e50432c34853f01aaa1c7e2f5fa2db51217610c092414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0574cc5f1d1d48276102a99dcfee2faffc46322e00df7f221223ca2c1a49ca373b82a7f076ce63b915143bf6131485d4cb08555fcffe7a22ae6266a81eb05da"} build_url:https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/E3K2OQp7T0-qRvvPKEiMTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bcbe276ec45d53588663fd41da4a3fda2d2637da9346c63ae0e0d5857ae0bab7515f233fc8ed7a6d66e50432c34853f01aaa1c7e2f5fa2db51217610c092414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0574cc5f1d1d48276102a99dcfee2faffc46322e00df7f221223ca2c1a49ca373b82a7f076ce63b915143bf6131485d4cb08555fcffe7a22ae6266a81eb05da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 06:06:13.613970) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 06:06:13.614347) ========= 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=5752742a61d0f534093fa7a9000001cb-1450791911.18432-559767272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 06:06:13.697350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 06:06:13.697695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 06:06:13.698005) ========= ========= Total master_lag: 0.21 =========