builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1452534744.69 results: success (0) buildid: 20160111073423 builduid: 5ec6f38094ca45ca8fe5f03662815e20 revision: 7f283083d5037b5115743585cc649956dc2ae731 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.694872) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.695679) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.696041) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.737099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.737417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.752534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.752918) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.803454) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.803782) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.804209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.804522) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 09:52:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.9M=0s 2016-01-11 09:52:24 (84.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165863 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.983542) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:24.983884) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013482 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:25.033472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:25.033843) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7f283083d5037b5115743585cc649956dc2ae731 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7f283083d5037b5115743585cc649956dc2ae731 --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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 09:52:25,096 truncating revision to first 12 chars 2016-01-11 09:52:25,096 Setting DEBUG logging. 2016-01-11 09:52:25,096 attempt 1/10 2016-01-11 09:52:25,096 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7f283083d503?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 09:52:25,358 unpacking tar archive at: mozilla-inbound-7f283083d503/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568726 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:25.629017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:25.629365) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:25.644174) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:25.644475) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 09:52:25.644964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-11 09:52:25.645315) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:52:25 INFO - MultiFileLogger online at 20160111 09:52:25 in /builds/slave/test-pgo 09:52:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:52:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:52:25 INFO - {'append_to_log': False, 09:52:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:52:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:52:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:52:25 INFO - 'branch': 'Mozilla-Inbound', 09:52:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:25 INFO - 'config_files': ('talos/linux_config.py',), 09:52:25 INFO - 'default_actions': ('clobber', 09:52:25 INFO - 'read-buildbot-config', 09:52:25 INFO - 'download-and-extract', 09:52:25 INFO - 'populate-webroot', 09:52:25 INFO - 'create-virtualenv', 09:52:25 INFO - 'install', 09:52:25 INFO - 'run-tests'), 09:52:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:25 INFO - 'download_minidump_stackwalk': True, 09:52:25 INFO - 'download_symbols': 'ondemand', 09:52:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:25 INFO - 'installer_path': 'installer.exe', 09:52:25 INFO - 'log_level': 'info', 09:52:25 INFO - 'log_name': 'talos', 09:52:25 INFO - 'log_to_console': True, 09:52:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:52:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:52:25 INFO - 'opt_config_files': (), 09:52:25 INFO - 'pip_index': False, 09:52:25 INFO - 'sps_profile': False, 09:52:25 INFO - 'sps_profile_interval': 0, 09:52:25 INFO - 'suite': 'dromaeojs-e10s', 09:52:25 INFO - 'system_bits': '32', 09:52:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:25 INFO - 'title': 'talos-linux64-ix-033', 09:52:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:25 INFO - 'use_talos_json': True, 09:52:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:52:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:25 INFO - 'work_dir': 'build'} 09:52:25 INFO - ##### 09:52:25 INFO - ##### Running clobber step. 09:52:25 INFO - ##### 09:52:25 INFO - Running pre-action listener: _resource_record_pre_action 09:52:25 INFO - Running main action method: clobber 09:52:25 INFO - rmtree: /builds/slave/test-pgo/build 09:52:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:52:26 INFO - Running post-action listener: _resource_record_post_action 09:52:26 INFO - ##### 09:52:26 INFO - ##### Running read-buildbot-config step. 09:52:26 INFO - ##### 09:52:26 INFO - Running pre-action listener: _resource_record_pre_action 09:52:26 INFO - Running main action method: read_buildbot_config 09:52:26 INFO - Using buildbot properties: 09:52:26 INFO - { 09:52:26 INFO - "project": "", 09:52:26 INFO - "product": "firefox", 09:52:26 INFO - "script_repo_revision": "production", 09:52:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:52:26 INFO - "repository": "", 09:52:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:52:26 INFO - "buildid": "20160111073423", 09:52:26 INFO - "pgo_build": "True", 09:52:26 INFO - "basedir": "/builds/slave/test-pgo", 09:52:26 INFO - "buildnumber": 618, 09:52:26 INFO - "slavename": "talos-linux64-ix-033", 09:52:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:52:26 INFO - "platform": "ubuntu64_hw", 09:52:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:52:26 INFO - "branch": "mozilla-inbound", 09:52:26 INFO - "repo_path": "integration/mozilla-inbound", 09:52:26 INFO - "revision": "7f283083d5037b5115743585cc649956dc2ae731", 09:52:26 INFO - "stage_platform": "linux64-pgo", 09:52:26 INFO - "builduid": "5ec6f38094ca45ca8fe5f03662815e20", 09:52:26 INFO - "slavebuilddir": "test" 09:52:26 INFO - } 09:52:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:52:26 INFO - Running post-action listener: _resource_record_post_action 09:52:26 INFO - ##### 09:52:26 INFO - ##### Running download-and-extract step. 09:52:26 INFO - ##### 09:52:26 INFO - Running pre-action listener: _resource_record_pre_action 09:52:26 INFO - Running main action method: download_and_extract 09:52:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:52: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')]} 09:52:26 INFO - https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:52:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/test_packages.json 09:52:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/test_packages.json 09:52:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:52:26 INFO - Downloaded 1302 bytes. 09:52:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:52:26 INFO - Using the following test package requirements: 09:52:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:52:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:52:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:26 INFO - u'jsshell-linux-x86_64.zip'], 09:52:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:52:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:52:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:52:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:52:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:52:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:52:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:52:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:52:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:52: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')]} 09:52:26 INFO - https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:52:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:52:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:52:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:29 INFO - Downloaded 24028977 bytes. 09:52:29 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 09:52:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:52:29 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 09:52:30 INFO - Return code: 0 09:52:30 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 09:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:30 INFO - https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:34 INFO - Downloaded 24028977 bytes. 09:52:34 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 09:52:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:52:34 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 09:52:36 INFO - Return code: 0 09:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:36 INFO - https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:38 INFO - Downloaded 11132285 bytes. 09:52:38 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 09:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:52:38 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 09:52:38 INFO - Return code: 0 09:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:38 INFO - https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KkXbtFiCR1mS00ybhJSgoQ/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 09:52:41 INFO - Downloaded 56040441 bytes. 09:52:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:52:41 INFO - mkdir: /builds/slave/test-pgo/properties 09:52:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:52:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:52:41 INFO - Contents: 09:52:41 INFO - build_url:https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:52:41 INFO - Running post-action listener: _resource_record_post_action 09:52:41 INFO - Running post-action listener: set_extra_try_arguments 09:52:41 INFO - ##### 09:52:41 INFO - ##### Running populate-webroot step. 09:52:41 INFO - ##### 09:52:41 INFO - Running pre-action listener: _resource_record_pre_action 09:52:41 INFO - Running main action method: populate_webroot 09:52:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:41 INFO - '--tppagecycles', 09:52:41 INFO - '7'], 09:52:41 INFO - 'tests': ['tsvgm']}}, 09:52:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:52:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:52:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:52:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'tests': ['damp', 'tps']}, 09:52:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['damp', 'tps']}, 09:52:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:52:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:41 INFO - 'other': {'tests': ['a11yr', 09:52:41 INFO - 'ts_paint', 09:52:41 INFO - 'tpaint', 09:52:41 INFO - 'sessionrestore', 09:52:41 INFO - 'sessionrestore_no_auto_restore']}, 09:52:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['a11yr', 09:52:41 INFO - 'ts_paint', 09:52:41 INFO - 'tpaint', 09:52:41 INFO - 'sessionrestore', 09:52:41 INFO - 'sessionrestore_no_auto_restore']}, 09:52:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['a11yr', 09:52:41 INFO - 'ts_paint', 09:52:41 INFO - 'tpaint', 09:52:41 INFO - 'sessionrestore', 09:52:41 INFO - 'sessionrestore_no_auto_restore']}, 09:52:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['a11yr', 09:52:41 INFO - 'ts_paint', 09:52:41 INFO - 'tpaint', 09:52:41 INFO - 'sessionrestore', 09:52:41 INFO - 'sessionrestore_no_auto_restore']}, 09:52:41 INFO - 'other_l64': {'tests': ['a11yr', 09:52:41 INFO - 'ts_paint', 09:52:41 INFO - 'tpaint', 09:52:41 INFO - 'sessionrestore', 09:52:41 INFO - 'sessionrestore_no_auto_restore']}, 09:52:41 INFO - 'other_nol64': {'tests': ['a11yr', 09:52:41 INFO - 'ts_paint', 09:52:41 INFO - 'tpaint', 09:52:41 INFO - 'sessionrestore', 09:52:41 INFO - 'sessionrestore_no_auto_restore']}, 09:52:41 INFO - 'svgr': {'tests': ['tsvgx', 09:52:41 INFO - 'tsvgr_opacity', 09:52:41 INFO - 'tart', 09:52:41 INFO - 'tscrollx', 09:52:41 INFO - 'cart']}, 09:52:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['tsvgx', 09:52:41 INFO - 'tsvgr_opacity', 09:52:41 INFO - 'tart', 09:52:41 INFO - 'tscrollx', 09:52:41 INFO - 'cart']}, 09:52:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'tests': ['tp5o']}, 09:52:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'talos_options': ['--e10s'], 09:52:41 INFO - 'tests': ['tp5o']}, 09:52:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'talos_options': ['--xperf_path', 09:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:41 INFO - 'tests': ['tp5n']}, 09:52:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:41 INFO - 'talos_options': ['--e10s', 09:52:41 INFO - '--xperf_path', 09:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:41 INFO - 'tests': ['tp5n']}}, 09:52:41 INFO - 'talos.zip': {'path': '', 09:52:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:41 INFO - Running post-action listener: _resource_record_post_action 09:52:41 INFO - ##### 09:52:41 INFO - ##### Running create-virtualenv step. 09:52:41 INFO - ##### 09:52:41 INFO - Running pre-action listener: _resource_record_pre_action 09:52:41 INFO - Running main action method: create_virtualenv 09:52:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:52:41 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 09:52:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:52:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:41 INFO - Using real prefix '/usr' 09:52:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:52:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:44 INFO - Installing pip.................done. 09:52:44 INFO - Return code: 0 09:52:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:52:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:52:44 INFO - Using env: {'DISPLAY': ':0', 09:52:44 INFO - 'HOME': '/home/cltbld', 09:52:44 INFO - 'LANG': 'en_US.UTF-8', 09:52:44 INFO - 'LANGUAGE': 'en_US:en', 09:52:44 INFO - 'LOGNAME': 'cltbld', 09:52:44 INFO - 'MAIL': '/var/mail/cltbld', 09:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:44 INFO - 'MOZ_NO_REMOTE': '1', 09:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:44 INFO - 'NO_EM_RESTART': '1', 09:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:44 INFO - 'SHELL': '/bin/bash', 09:52:44 INFO - 'SHLVL': '1', 09:52:44 INFO - 'TERM': 'linux', 09:52:44 INFO - 'TMOUT': '86400', 09:52:44 INFO - 'USER': 'cltbld', 09:52:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:44 INFO - '_': '/tools/buildbot/bin/python'} 09:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:44 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 09:52:44 INFO - Cleaning up... 09:52:44 INFO - Return code: 0 09:52:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:52:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:52:44 INFO - Using env: {'DISPLAY': ':0', 09:52:44 INFO - 'HOME': '/home/cltbld', 09:52:44 INFO - 'LANG': 'en_US.UTF-8', 09:52:44 INFO - 'LANGUAGE': 'en_US:en', 09:52:44 INFO - 'LOGNAME': 'cltbld', 09:52:44 INFO - 'MAIL': '/var/mail/cltbld', 09:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:44 INFO - 'MOZ_NO_REMOTE': '1', 09:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:44 INFO - 'NO_EM_RESTART': '1', 09:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:44 INFO - 'SHELL': '/bin/bash', 09:52:44 INFO - 'SHLVL': '1', 09:52:44 INFO - 'TERM': 'linux', 09:52:44 INFO - 'TMOUT': '86400', 09:52:44 INFO - 'USER': 'cltbld', 09:52:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:44 INFO - '_': '/tools/buildbot/bin/python'} 09:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:44 INFO - Downloading/unpacking psutil>=0.7.1 09:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:52:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:52:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:46 INFO - Installing collected packages: psutil 09:52:46 INFO - Running setup.py install for psutil 09:52:46 INFO - building 'psutil._psutil_linux' extension 09:52:46 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 09:52:46 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 09:52:46 INFO - building 'psutil._psutil_posix' extension 09:52:46 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 09:52:46 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 09:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:47 INFO - Successfully installed psutil 09:52:47 INFO - Cleaning up... 09:52:47 INFO - Return code: 0 09:52:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:52:47 INFO - Using env: {'DISPLAY': ':0', 09:52:47 INFO - 'HOME': '/home/cltbld', 09:52:47 INFO - 'LANG': 'en_US.UTF-8', 09:52:47 INFO - 'LANGUAGE': 'en_US:en', 09:52:47 INFO - 'LOGNAME': 'cltbld', 09:52:47 INFO - 'MAIL': '/var/mail/cltbld', 09:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:47 INFO - 'MOZ_NO_REMOTE': '1', 09:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:47 INFO - 'NO_EM_RESTART': '1', 09:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:47 INFO - 'SHELL': '/bin/bash', 09:52:47 INFO - 'SHLVL': '1', 09:52:47 INFO - 'TERM': 'linux', 09:52:47 INFO - 'TMOUT': '86400', 09:52:47 INFO - 'USER': 'cltbld', 09:52:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:47 INFO - '_': '/tools/buildbot/bin/python'} 09:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:52:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:52:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:52:49 INFO - Installing collected packages: mozsystemmonitor 09:52:49 INFO - Running setup.py install for mozsystemmonitor 09:52:49 INFO - Successfully installed mozsystemmonitor 09:52:49 INFO - Cleaning up... 09:52:49 INFO - Return code: 0 09:52:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:52:49 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')]} 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:49 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')]} 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:49 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 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:49 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 09:52:49 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 09:52:49 INFO - Using env: {'DISPLAY': ':0', 09:52:49 INFO - 'HOME': '/home/cltbld', 09:52:49 INFO - 'LANG': 'en_US.UTF-8', 09:52:49 INFO - 'LANGUAGE': 'en_US:en', 09:52:49 INFO - 'LOGNAME': 'cltbld', 09:52:49 INFO - 'MAIL': '/var/mail/cltbld', 09:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:49 INFO - 'MOZ_NO_REMOTE': '1', 09:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:49 INFO - 'NO_EM_RESTART': '1', 09:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:49 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:49 INFO - 'SHELL': '/bin/bash', 09:52:49 INFO - 'SHLVL': '1', 09:52:49 INFO - 'TERM': 'linux', 09:52:49 INFO - 'TMOUT': '86400', 09:52:49 INFO - 'USER': 'cltbld', 09:52:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:49 INFO - '_': '/tools/buildbot/bin/python'} 09:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:52:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 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 09:52:51 INFO - Downloading docopt-0.6.1.tar.gz 09:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:51 INFO - Running setup.py install for blobuploader 09:52:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:52:51 INFO - Running setup.py install for requests 09:52:52 INFO - Running setup.py install for docopt 09:52:52 INFO - Successfully installed blobuploader requests docopt 09:52:52 INFO - Cleaning up... 09:52:52 INFO - Return code: 0 09:52:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:52 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 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:52 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 09:52:52 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 09:52:52 INFO - Using env: {'DISPLAY': ':0', 09:52:52 INFO - 'HOME': '/home/cltbld', 09:52:52 INFO - 'LANG': 'en_US.UTF-8', 09:52:52 INFO - 'LANGUAGE': 'en_US:en', 09:52:52 INFO - 'LOGNAME': 'cltbld', 09:52:52 INFO - 'MAIL': '/var/mail/cltbld', 09:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:52 INFO - 'MOZ_NO_REMOTE': '1', 09:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:52 INFO - 'NO_EM_RESTART': '1', 09:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:52 INFO - 'SHELL': '/bin/bash', 09:52:52 INFO - 'SHLVL': '1', 09:52:52 INFO - 'TERM': 'linux', 09:52:52 INFO - 'TMOUT': '86400', 09:52:52 INFO - 'USER': 'cltbld', 09:52:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:52 INFO - '_': '/tools/buildbot/bin/python'} 09:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:52 INFO - Running setup.py (path:/tmp/pip-ODZ5BS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:52 INFO - Running setup.py (path:/tmp/pip-3Xg9Hj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:52 INFO - Running setup.py (path:/tmp/pip-TPZPkn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:52 INFO - Running setup.py (path:/tmp/pip-KJcU2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:52 INFO - Running setup.py (path:/tmp/pip-Im8Zg7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:53 INFO - Running setup.py (path:/tmp/pip-J9YUP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:53 INFO - Running setup.py (path:/tmp/pip-taDuXw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:53 INFO - Running setup.py (path:/tmp/pip-dPtr7j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:53 INFO - Running setup.py (path:/tmp/pip-00O5x0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:53 INFO - Running setup.py (path:/tmp/pip-QbPHcy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:53 INFO - Running setup.py (path:/tmp/pip-svAYBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:53 INFO - Running setup.py (path:/tmp/pip-AW8_KM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:53 INFO - Running setup.py (path:/tmp/pip-SOUUrD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:53 INFO - Running setup.py (path:/tmp/pip-t0viap-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:53 INFO - Running setup.py (path:/tmp/pip-ORaRpc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:53 INFO - Running setup.py (path:/tmp/pip-rq80Cz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:53 INFO - Running setup.py (path:/tmp/pip-7oTfaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:53 INFO - Running setup.py install for manifestparser 09:52:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Running setup.py install for mozcrash 09:52:54 INFO - Running setup.py install for mozdebug 09:52:54 INFO - Running setup.py install for mozdevice 09:52:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Running setup.py install for mozfile 09:52:54 INFO - Running setup.py install for mozhttpd 09:52:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Running setup.py install for mozinfo 09:52:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Running setup.py install for mozInstall 09:52:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Running setup.py install for mozleak 09:52:54 INFO - Running setup.py install for mozlog 09:52:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:52:54 INFO - Running setup.py install for moznetwork 09:52:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:52:55 INFO - Running setup.py install for mozprocess 09:52:55 INFO - Running setup.py install for mozprofile 09:52:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:52:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:52:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:52:55 INFO - Running setup.py install for mozrunner 09:52:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:52:55 INFO - Running setup.py install for mozscreenshot 09:52:55 INFO - Running setup.py install for moztest 09:52:55 INFO - Running setup.py install for mozversion 09:52:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:52:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:52:55 INFO - Cleaning up... 09:52:55 INFO - Return code: 0 09:52:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:55 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 09:52:55 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 09:52:55 INFO - Using env: {'DISPLAY': ':0', 09:52:55 INFO - 'HOME': '/home/cltbld', 09:52:55 INFO - 'LANG': 'en_US.UTF-8', 09:52:55 INFO - 'LANGUAGE': 'en_US:en', 09:52:55 INFO - 'LOGNAME': 'cltbld', 09:52:55 INFO - 'MAIL': '/var/mail/cltbld', 09:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:55 INFO - 'MOZ_NO_REMOTE': '1', 09:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:55 INFO - 'NO_EM_RESTART': '1', 09:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:55 INFO - 'SHELL': '/bin/bash', 09:52:55 INFO - 'SHLVL': '1', 09:52:55 INFO - 'TERM': 'linux', 09:52:55 INFO - 'TMOUT': '86400', 09:52:55 INFO - 'USER': 'cltbld', 09:52:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:55 INFO - '_': '/tools/buildbot/bin/python'} 09:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:55 INFO - Running setup.py (path:/tmp/pip-_iKuO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:56 INFO - Running setup.py (path:/tmp/pip-vwGhk_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:56 INFO - Running setup.py (path:/tmp/pip-J3wkJV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:56 INFO - Running setup.py (path:/tmp/pip-bcszCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:56 INFO - Running setup.py (path:/tmp/pip-DAfmuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:56 INFO - Running setup.py (path:/tmp/pip-JPwd5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:56 INFO - Running setup.py (path:/tmp/pip-vHEW6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:56 INFO - Running setup.py (path:/tmp/pip-tFZY9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:56 INFO - Running setup.py (path:/tmp/pip-3dECGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:56 INFO - Running setup.py (path:/tmp/pip-7RdkCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:56 INFO - Running setup.py (path:/tmp/pip-O5oE1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:56 INFO - Running setup.py (path:/tmp/pip-a00MSh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:56 INFO - Running setup.py (path:/tmp/pip-iAAZYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:56 INFO - Running setup.py (path:/tmp/pip-Zivx9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:56 INFO - Running setup.py (path:/tmp/pip-ziWziw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:57 INFO - Running setup.py (path:/tmp/pip-X8C0b5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:57 INFO - Running setup.py (path:/tmp/pip-Y7AuLg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:57 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)) 09:52:57 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)) 09:52:57 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)) 09:52:57 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)) 09:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:52:57 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)) 09:52:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - Downloading blessings-1.5.1.tar.gz 09:52:58 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 09:52:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:52:58 INFO - Installing collected packages: blessings 09:52:58 INFO - Running setup.py install for blessings 09:52:59 INFO - Successfully installed blessings 09:52:59 INFO - Cleaning up... 09:52:59 INFO - Return code: 0 09:52:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:52:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:52:59 INFO - Reading from file tmpfile_stdout 09:52:59 INFO - Current package versions: 09:52:59 INFO - argparse == 1.2.1 09:52:59 INFO - blessings == 1.5.1 09:52:59 INFO - blobuploader == 1.2.4 09:52:59 INFO - docopt == 0.6.1 09:52:59 INFO - manifestparser == 1.1 09:52:59 INFO - mozInstall == 1.12 09:52:59 INFO - mozcrash == 0.16 09:52:59 INFO - mozdebug == 0.1 09:52:59 INFO - mozdevice == 0.47 09:52:59 INFO - mozfile == 1.2 09:52:59 INFO - mozhttpd == 0.7 09:52:59 INFO - mozinfo == 0.9 09:52:59 INFO - mozleak == 0.1 09:52:59 INFO - mozlog == 3.1 09:52:59 INFO - moznetwork == 0.27 09:52:59 INFO - mozprocess == 0.22 09:52:59 INFO - mozprofile == 0.28 09:52:59 INFO - mozrunner == 6.11 09:52:59 INFO - mozscreenshot == 0.1 09:52:59 INFO - mozsystemmonitor == 0.0 09:52:59 INFO - moztest == 0.7 09:52:59 INFO - mozversion == 1.4 09:52:59 INFO - psutil == 3.1.1 09:52:59 INFO - requests == 1.2.3 09:52:59 INFO - wsgiref == 0.1.2 09:52:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52: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')]} 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:59 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 09:52:59 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 09:52:59 INFO - Using env: {'DISPLAY': ':0', 09:52:59 INFO - 'HOME': '/home/cltbld', 09:52:59 INFO - 'LANG': 'en_US.UTF-8', 09:52:59 INFO - 'LANGUAGE': 'en_US:en', 09:52:59 INFO - 'LOGNAME': 'cltbld', 09:52:59 INFO - 'MAIL': '/var/mail/cltbld', 09:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:59 INFO - 'MOZ_NO_REMOTE': '1', 09:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:59 INFO - 'NO_EM_RESTART': '1', 09:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:59 INFO - 'SHELL': '/bin/bash', 09:52:59 INFO - 'SHLVL': '1', 09:52:59 INFO - 'TERM': 'linux', 09:52:59 INFO - 'TMOUT': '86400', 09:52:59 INFO - 'USER': 'cltbld', 09:52:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:59 INFO - '_': '/tools/buildbot/bin/python'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 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)) 09:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:52:59 INFO - Cleaning up... 09:52:59 INFO - Return code: 0 09:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:52: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')]} 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:52:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:52:59 INFO - Using env: {'DISPLAY': ':0', 09:52:59 INFO - 'HOME': '/home/cltbld', 09:52:59 INFO - 'LANG': 'en_US.UTF-8', 09:52:59 INFO - 'LANGUAGE': 'en_US:en', 09:52:59 INFO - 'LOGNAME': 'cltbld', 09:52:59 INFO - 'MAIL': '/var/mail/cltbld', 09:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:59 INFO - 'MOZ_NO_REMOTE': '1', 09:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:59 INFO - 'NO_EM_RESTART': '1', 09:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:59 INFO - 'SHELL': '/bin/bash', 09:52:59 INFO - 'SHLVL': '1', 09:52:59 INFO - 'TERM': 'linux', 09:52:59 INFO - 'TMOUT': '86400', 09:52:59 INFO - 'USER': 'cltbld', 09:52:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:59 INFO - '_': '/tools/buildbot/bin/python'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 INFO - Downloading/unpacking jsonschema 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:53:01 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 09:53:01 INFO - Downloading/unpacking functools32 (from jsonschema) 09:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:01 INFO - Downloading functools32-3.2.3-2.tar.gz 09:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:53:01 INFO - warning: no files found matching '*.txt' 09:53:01 INFO - no previously-included directories found matching 'build' 09:53:01 INFO - no previously-included directories found matching 'dist' 09:53:01 INFO - no previously-included directories found matching '.git*' 09:53:01 INFO - Installing collected packages: jsonschema, functools32 09:53:01 INFO - Running setup.py install for functools32 09:53:01 INFO - warning: no files found matching '*.txt' 09:53:01 INFO - no previously-included directories found matching 'build' 09:53:01 INFO - no previously-included directories found matching 'dist' 09:53:01 INFO - no previously-included directories found matching '.git*' 09:53:01 INFO - Successfully installed jsonschema functools32 09:53:01 INFO - Cleaning up... 09:53:01 INFO - Return code: 0 09:53:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a1c124f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c41480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', '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 09:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:53:01 INFO - Using env: {'DISPLAY': ':0', 09:53:01 INFO - 'HOME': '/home/cltbld', 09:53:01 INFO - 'LANG': 'en_US.UTF-8', 09:53:01 INFO - 'LANGUAGE': 'en_US:en', 09:53:01 INFO - 'LOGNAME': 'cltbld', 09:53:01 INFO - 'MAIL': '/var/mail/cltbld', 09:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:01 INFO - 'MOZ_NO_REMOTE': '1', 09:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:01 INFO - 'NO_EM_RESTART': '1', 09:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:53:01 INFO - 'SHELL': '/bin/bash', 09:53:01 INFO - 'SHLVL': '1', 09:53:01 INFO - 'TERM': 'linux', 09:53:01 INFO - 'TMOUT': '86400', 09:53:01 INFO - 'USER': 'cltbld', 09:53:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:01 INFO - '_': '/tools/buildbot/bin/python'} 09:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:02 INFO - Downloading/unpacking flake8 09:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:53:03 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 09:53:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:53:04 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 09:53:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:04 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 09:53:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:04 INFO - no previously-included directories found matching 'docs/_build' 09:53:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:53:04 INFO - Running setup.py install for pep8 09:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:04 INFO - no previously-included directories found matching 'docs/_build' 09:53:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:53:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:53:04 INFO - Cleaning up... 09:53:04 INFO - Return code: 0 09:53:04 INFO - Running post-action listener: _resource_record_post_action 09:53:04 INFO - Running post-action listener: _start_resource_monitoring 09:53:04 INFO - Starting resource monitoring. 09:53:04 INFO - ##### 09:53:04 INFO - ##### Running install step. 09:53:04 INFO - ##### 09:53:04 INFO - Running pre-action listener: _resource_record_pre_action 09:53:04 INFO - Running main action method: install 09:53:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:53:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:53:05 INFO - Reading from file tmpfile_stdout 09:53:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:53:05 INFO - Reading from file tmpfile_stdout 09:53:05 INFO - Output received: 09:53:05 INFO - Usage: mozinstall [options] installer 09:53:05 INFO - Options: 09:53:05 INFO - -h, --help show this help message and exit 09:53:05 INFO - -d DEST, --destination=DEST 09:53:05 INFO - Directory to install application into. [default: 09:53:05 INFO - "/builds/slave/test-pgo"] 09:53:05 INFO - --app=APP Application being installed. [default: firefox] 09:53:05 INFO - mkdir: /builds/slave/test-pgo/build/application 09:53:05 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'] 09:53:05 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 09:53:21 INFO - Reading from file tmpfile_stdout 09:53:21 INFO - Output received: 09:53:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:53:21 INFO - Running post-action listener: _resource_record_post_action 09:53:21 INFO - ##### 09:53:21 INFO - ##### Running run-tests step. 09:53:21 INFO - ##### 09:53:21 INFO - Running pre-action listener: _resource_record_pre_action 09:53:21 INFO - Running main action method: run_tests 09:53:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:53:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:53:21 INFO - Python 2.7.3 09:53:21 INFO - Return code: 0 09:53:21 INFO - grabbing minidump binary from tooltool 09:53:21 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')]} 09:53:21 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 0x2cd0660>, '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 0x2cd1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:53:21 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 09:53:21 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 09:53:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:21 INFO - Return code: 0 09:53:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:53:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:53:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:53:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:53:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:53:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:53:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:53:22 INFO - Return code: 0 09:53:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:53:22 INFO - Using env: {'DISPLAY': ':0', 09:53:22 INFO - 'HOME': '/home/cltbld', 09:53:22 INFO - 'LANG': 'en_US.UTF-8', 09:53:22 INFO - 'LANGUAGE': 'en_US:en', 09:53:22 INFO - 'LOGNAME': 'cltbld', 09:53:22 INFO - 'MAIL': '/var/mail/cltbld', 09:53:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:53:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:22 INFO - 'MOZ_NO_REMOTE': '1', 09:53:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:22 INFO - 'NO_EM_RESTART': '1', 09:53:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:53:22 INFO - 'PWD': '/builds/slave/test-pgo', 09:53:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:53:22 INFO - 'SHELL': '/bin/bash', 09:53:22 INFO - 'SHLVL': '1', 09:53:22 INFO - 'TERM': 'linux', 09:53:22 INFO - 'TMOUT': '86400', 09:53:22 INFO - 'USER': 'cltbld', 09:53:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771', 09:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:22 INFO - '_': '/tools/buildbot/bin/python'} 09:53:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:53:22 INFO - mozversion application_buildid: 20160111073423 09:53:22 INFO - mozversion application_changeset: 7f283083d5037b5115743585cc649956dc2ae731 09:53:22 INFO - mozversion application_display_name: Nightly 09:53:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:22 INFO - mozversion application_name: Firefox 09:53:22 INFO - mozversion application_remotingname: firefox 09:53:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:53:22 INFO - mozversion application_vendor: Mozilla 09:53:22 INFO - mozversion application_version: 46.0a1 09:53:22 INFO - mozversion platform_buildid: 20160111073423 09:53:22 INFO - mozversion platform_changeset: 7f283083d5037b5115743585cc649956dc2ae731 09:53:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:53:22 INFO - mozversion platform_version: 46.0a1 09:53:22 INFO - using testdate: 1452534802 09:53:22 INFO - actual date: 1452534802 09:53:22 INFO - starting webserver on 'localhost:56195' 09:53:22 INFO - SUITE-START | Running 3 tests 09:53:22 INFO - TEST-START | dromaeo_css 09:53:22 INFO - operating with platform_type : linux_ 09:53:22 INFO - Initialising browser for dromaeo_css test... 09:53:22 INFO - TEST-INFO | started process 20524 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvrWq_h/profile http://localhost:56195/getInfo.html) 09:53:26 INFO - PROCESS | 20524 | 09:53:26 INFO - PROCESS | 20524 | (process:20610): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:53:27 INFO - PROCESS | 20524 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 09:53:28 INFO - PROCESS | 20524 | __metrics Screen width/height:1600/1200 09:53:28 INFO - PROCESS | 20524 | colorDepth:24 09:53:28 INFO - PROCESS | 20524 | Browser inner width/height: 1024/697 09:53:28 INFO - PROCESS | 20524 | __metrics 09:53:28 INFO - PROCESS | 20524 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:53:29 INFO - TEST-INFO | 20524: exit 0 09:53:29 INFO - Browser initialized. 09:53:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:53:29 INFO - TEST-INFO | started process 20660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvrWq_h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:30 INFO - PROCESS | 20660 | 09:53:30 INFO - PROCESS | 20660 | (process:20719): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:53:41 INFO - PROCESS | 20660 | RSS: Main: 150495232 09:53:41 INFO - PROCESS | 20660 | 09:54:30 INFO - PROCESS | 20660 | 1452534870733 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] 09:56:39 INFO - PROCESS | 20660 | Cycle 1(1): loaded http://localhost:56195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56195/tests/dromaeo/cssquery-ext.html) 09:56:40 INFO - PROCESS | 20660 | RSS: Main: 157188096 09:56:40 INFO - PROCESS | 20660 | 09:59:42 INFO - PROCESS | 20660 | Cycle 1(1): loaded http://localhost:56195/tests/dromaeo/cssquery-ext.html (next: http://localhost:56195/tests/dromaeo/cssquery-jquery.html) 09:59:43 INFO - PROCESS | 20660 | RSS: Main: 154734592 09:59:43 INFO - PROCESS | 20660 | 10:02:45 INFO - PROCESS | 20660 | Cycle 1(1): loaded http://localhost:56195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56195/tests/dromaeo/cssquery-mootools.html) 10:02:45 INFO - PROCESS | 20660 | RSS: Main: 154456064 10:02:45 INFO - PROCESS | 20660 | 10:05:47 INFO - PROCESS | 20660 | Cycle 1(1): loaded http://localhost:56195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56195/tests/dromaeo/cssquery-prototype.html) 10:05:48 INFO - PROCESS | 20660 | RSS: Main: 153030656 10:05:48 INFO - PROCESS | 20660 | 10:08:50 INFO - PROCESS | 20660 | Cycle 1(1): loaded http://localhost:56195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56195/tests/dromaeo/cssquery-yui.html) 10:08:51 INFO - PROCESS | 20660 | RSS: Main: 153124864 10:08:51 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | Cycle 1(1): loaded http://localhost:56195/tests/dromaeo/cssquery-yui.html (next: http://localhost:56195/tests/dromaeo/cssquery-dojo.html) 10:11:53 INFO - PROCESS | 20660 | RSS: Main: 155742208 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | __start_tp_report 10:11:53 INFO - PROCESS | 20660 | _x_x_mozilla_page_load 10:11:53 INFO - PROCESS | 20660 | _x_x_mozilla_page_load_details 10:11:53 INFO - PROCESS | 20660 | |i|pagename|runs| 10:11:53 INFO - PROCESS | 20660 | |0;dojo.html;3210.406074876148;3226.9193270168257;3262.983685081574;3267.0688853676706;3280.147161737949;5254.553362964152;5282.418933917266;5287.2069189621525;5295.338082739658;5315.468453154683;5256.947430525694;5303.893922121565;5306.230596563506;5312.548433383167;5314.016906872222;4880.6095512358925;4919.60643148549;4925.630577706668;4999.450060493343;5012.799488020475;4925.556699897009;4974.3533340665845;4976.377952755905;5029.924551131736;5056.29211910331;4598.954010459886;4842.104210721028;4919.975400123012;4937.259411088366;4941.481144479814;4901.534354236342;4930.186519224324;4941.481144479814;4964.156093464084;4978.850634480971;4801.2798080287885;4879.731614761186;4906.092372910987;4923.556879880828;4992.375953005874;5188.740562971874;5241.240020197089;5243.68537887728;5259.658122222043;5311.548518375943;5830.650160990354;5867.354590994987;5869.148973398876;5869.85325366865;5871;5737.827865164052;5786;5867.178594996704;5911.290645122613;5924.289085309747;5474.233607294982;5491.121420572689;5495.53287970523;5509.090999984997;5555.138953462219;5963.970180149072;5972.372900845348;5973.223480947449;5973.850653733692;5974.1636170935235;5681.971590142106;5725.198472213893;5733.741981610838;5746.913796293059;5791.507721843691;5712.171735098387;5715.514181294553;5735.569832262597;5736.627119237236;5759.971200143972;5616.1014237721765;5665.178549110438;5671.716414179275;5672.801451949162;5704.4295570443455;5588.0779671354585;5678.801241956512;5730.88247791685;5743.282089738783;5857.531397488191;4469.329600559942;4474.530174331713;4487.618552423015;4492.505824359318;4500.279955207151;3977.8209980550946;3978.4430179774854;3981.6217459341315;4048.6963477739287;4068.9186216276103;5346.518813306821;5374.704391258519;5416;5444.128939369682;5454.045542030129;5762.164486149485;5821.854453638693;5826.504747096459;5835.503982161564;5836.766529338864;5283;5330.067238233293;5395.595330350239;5397.541208997279;5399.622026458111;4898.53463920927;4917.7786999585105;4938.481459446706;4956.107900577858;4960.578350840146;5856.531477481876;5927.585069045212;5931.0213814720955;5933.6736479493175;5944.851378715567;5630.324361076697;5735.11105778605;5813.215215945793;5828.067509198508;5831;5875.500582450369;5950.077737950624;5964.224650795369;5971.820845374646;6013.128096426081;5667.546596272371;5690.630109042899;5698.344690360662;5701.971490142523;5726.4273572642405;5714.3714191438075;5833.854153646193;5840.2991641003355;5848.590598658223;5860.765569377178;5601.271834661468;5617.662940223599;5716.171155182558;5785.392533783892;5825.330087040044;5724.0555308375315;5732.512736417451;5752.424757524214;5754.05058165398;5757.91363129545;5581.134924086773;5610.831675049755;5641.943580564306;5662.971685141712;5665.546756259571;5592.944070559242;5629.324481062299;5661.207430959586;5735.942640573541;5778.971105144616;5572.247746554163;5596.552275817843;5600.439956004367;5603.047481928001;5608.831735047955 10:11:53 INFO - PROCESS | 20660 | |1;ext.html;520.3599572525793;532.5207313417924;533.5758072332496;552.6766841397782;554.4510934175165;36031.27937441253;36777.632223677756;36789.81605091971;36801.81599092008;36854.447183292235;39742.40386394199;40759;40791.59208407915;40793;40861.38707919376;8342.249197572202;8456.112108228639;8459.984801823759;8489.830203395928;8523.445976011539;8314.750557483256;8367.916320836775;8451;8608.956955215215;8610.397272190949;8559.700410485635;8590.484570925764;8628.396012279143;8631.913680863174;8666.480011199317;8420.115887831782;8421.578921053922;8487.40588158829;8626.137386261387;8641.092685268019;8527.232549070613;8601.397902146853;8669.046404895456;8678.652853885837;8682.956585217096;39387.40918886219;40094.198116037514;40252;40268.597314026774;40370.394444083366;3107.6115485564305;3353.8658453661824;3752.6434988676033;3755.9436608450897;3861.9806900965596;30006.099817005525;30742.07773766768;30811.229719256975;30950.845245773853;31148.688513114805;3567.340042092221;3613.1870329175986;3619.819009049537;3785.6968148033493;3855.151866589346;265385;265565;266150;266583;267102;42419.363709544385;59460;59700.70149649224;59922;60109;42752;43099.784501077294;43567.12865742667;43675;43679.344809827875;15299.311530981133;15433.691326173413;15585.610359741097;15594.220288985505;15624.21878906073;12409.62771116868;12474.126811123317;12515.937420313023;12517.561885334151;12519.061070419755;13907.122538457179;14134.50529231472;14194.645133871529;14218.786718199235;14269.571912842632;5800;5804.390538993429;5835.1968692596;5867.70661466925;5914.319853216849;911.9316051296179;922.524899676667;965.5944503308486;1014.9949250253701;1067.7223921780237;29013;31331.84334078315;31449.685503145134;32089.839550802095;32346.514802277983;1032.4218437674926;1048.9003544663244;1049.8425236214475;1103.6358001859367;1109.7170221593442;14587;15017.399304027716;15117.54647360581;15337.53987380358;15580;396218;396932;398422;399383;399386;54212.45787542074;54602.45397546053;54690.45309546933;54731.452685472635;54877.72561137169;1368.5278578890268;1369.103237379518;1381.6407733989236;1392.5195807446414;1395.1001603965587;28537;29249.41501170007;29362.265943350732;29397.559036614897;29723.108306750833;46555.767221165035;46725.59823205309;46900.530994689616;47250.291245632034;47625.28562071641;293811;294246;295832;295930;296693;32314.35371292608;41973.38292787852;43708;44213.11573768571;44385.33421998608;39393.40909886411;40406.19187616173;41413.1717365657;41505.79247103745;42147.7892610535;34719.65280347164;35550.46674299836;35587.82206088953;36414;38464.6153538461;36625.16874156335;36954.44568331423;37549;38052.809735951145;38247;35063;36135.27729445449;36140.8192959044;36180;36581.45127823031;32072.67927320697;32369.190770230933;34175.487367689006;34397.656023440446;34701.47947780836;25630.743692562835;25764.61353079743;25782.484350312512;26033;26168.34579135537 10:11:53 INFO - PROCESS | 20660 | |2;jquery.html;358.77935069931993;359.88663570975143;360.50070652146786;360.88451695457445;364.03167574252495;13354.532591359304;13599.864001360009;16163.676726465479;16743.66512669746;17628;15385.92307038466;15679.686406271867;16133.43532976346;16188.838111618881;16225.188740562984;4894.804207831682;5325.547328477084;5338.546223571001;5349.438308977559;5356.464353564651;4908.533689299511;5114.948850511503;5126.948730512703;5128.205128205134;5184.688918664873;4861.927071093936;5113.437521872591;5142.228665700156;5152.510511501401;5159;5194.662346947436;5315.468453154692;5352.759125839308;5365.007473617374;5376.220448035033;5117.1556693145585;5164.6384753067305;5167.147420675622;5173.844784656429;5174.249733788617;19722.802771972383;19880.105395257247;20002.59994800096;20494;20665.690014649794;1982.553925366781;2029.995152399557;2051.9589608207903;2060.8969551522364;2287.096596844254;8799.34004949625;8959.283257339397;9055.456672599665;9182.540872956326;9326.90673093274;1700.8071374222347;1753.973690394645;1762.6034142318003;1765.7263124215767;1773.3881810775263;50883.49116508824;51672.48327516714;53149.73425132888;53436.73281633567;54111.18833217505;9800.754981125529;10173.84739228912;10270.127039201752;10270.229732769923;10305.330153539995;13157.671058223621;13220.471181152838;13245.602631920865;13253.536126235536;13298.268595227355;7442.85114297711;7627.389808815282;7630.618469076524;7635.350995165362;7639.961800190964;7346.265373462611;7351.191368949411;7363.7422690205585;7388.408927285912;7397.482176247719;4224.324108142682;4253.3194688849635;4385.057212699221;4419.42547468827;4447.488538818077;1806.2865168258727;1869.5139263791511;1871.5321169707572;1874.9062546872601;1879.2201236486978;810.4772421788032;897.708244820436;946.8816397950256;997.3018886779283;1047.6228557719214;16098.63161631251;16141.919290403473;16213.675726485404;16576.585585360463;16649.91675041617;883.6686242659002;943.5470973932551;1005.6329439754437;1027.8047171037629;1044.237706474263;9289.814203716023;9354.766130846647;9473.526323683789;9650.903490965;9739.853902191473;520276;526672;528098;532987;540965;42550;42936.57063429388;74949.87575186377;75268.99999999891;78426;1124.241137232365;1136.6362763915467;1143.6168883424145;1153.169717803197;1159.0437888741822;15055.696541997373;15115.244237787847;15203.391864325304;15264.465743698916;15281.923590381977;33736;34268.65731342655;34734;34847.303053939286;35149.8242508796;44857;44956.325655115856;46528.53471465242;46735.53264467312;47617.761911190224;6806.659667016728;6983.441324694114;7203.783886483414;7244.094488188976;7397.593132377771;10538.947305263731;10543.89456105429;10725.195610329101;11188.272762270426;11262.662120136409;9580.18568421692;9652.951735241279;9838.75403114928;9846.45844478532;10154.796904062025;10034.247431442525;10367.27429079957;10641.467926603793;10641.574337026432;10700.929907009237;10123.797524049625;10287.43419111956;10401;10585.629502967358;10686.771021332646;7354.816129596803;7533.623318834146;7574.659140338587;7575.772726818204;7609.543427394374;8123.7156699515235;8851.734447966572;9421.905780942103;10320.071193592612;10375.066244038073 10:11:53 INFO - PROCESS | 20660 | |3;mootools.html;1443.1341195282828;1489.4414594527052;1657.635320229549;1793.4798908316588;1825.9543511412205;7474.364679002285;7618.162002179763;7677.8848317275215;7784.571848548328;7945.165757595456;7963.3231175350165;8008.639611217494;8081.959590202056;8096.392770542204;8109.553974531398;2348.7181538215395;2370.715514138306;2375.228050883461;2376.786089251967;2382.297222319411;2404.038384646138;2422.454947636785;2434.4035711250767;2434.4887573609476;2435.914742983996;2316.444053427174;2363.1728894886824;2381.8928148233285;2392.6889504364494;2399.9640005399933;2353.5881220786296;2354.9646755298686;2371.9525609487887;2393.9162129325478;2400.759924007603;2411.348935787345;2420.721617014031;2429.149797570854;2438.5366780311683;2440.755924407563;7845.137034926153;7848.921510784933;7861.371090312761;7865.488743231672;7917.445778795487;4974.955259395531;5036.21938599514;5052.671576347526;5060.84817455477;5112.156494178456;3057.1745628680133;3059.724624783758;3114.797538160012;3137.51368537877;3143;995.6813819577739;1002.7042022603349;1019.9643012494602;1029.1663752360537;1053.425882893817;10978.670639880816;11027.944860275647;11082.335059896352;11125.833112503318;11136.109111271078;4357.172137293967;4367.497737760198;4477.462704475483;4480;4494.52807455219;8875.866861997076;8876.51179185151;8878.73363799087;8887.333449991276;8898.154675305836;4812.302216178705;4815.2054910939305;4861.368022157168;4882.462929077798;4897.0450762101045;4416.712913660602;4437.267850804646;4443.133588950188;4474.082813023322;4504.797284122223;3497.667721566447;3589.8743543976357;3611.566612006576;3630.745847790682;3639.490471334015;1063.4310643805527;1090.5855774805682;1111.9388433636227;1113.0650253786857;1148.8219326004482;990.0792263195153;1059.998301604976;1145.7192987718063;1148.724306166514;1341.8121462995189;7177.3899218567;7188.892166617505;7225.205227424979;7230.746923857745;7254.492185547067;607.7872744539465;616.0420546050844;616.8396216983616;617.1945610977717;759.35509554141;5253.212018197301;5275.366955965309;5317.601179911522;5322.787088516493;5366.91949620756;9126.771830704285;9275.675351362805;9289.62841486333;9352.859707104399;9415.293852961055;9225.261979041661;9229.261659067259;9261.583228754722;9271.165595096474;9303.813923721487;7304.342609165201;7481.476296659182;7492.550446973199;7514.0607424071995;7540.547567145989;7292.781216563511;7388.963055184689;7395.371393431618;7425.554466732014;7449.5902725350625;8513.276371508491;8524.914750852413;8640.395172337876;8684.78288042804;8742.956285218534;8507.787305317417;8885.644574216958;8887.466751994902;8921.464712117293;8985.101489850962;6801.659917004031;6861.55399899005;6902.206246281742;6902.585844849325;6931.480138989495;7232.855342893218;7336.229695881855;7378.372838308804;7428.73999410018;7455.701771929279;7068.11648543932;7219.530730502501;7236.746713864989;7314.670839812327;7454.925450745423;6842.55523390978;6867.866801977618;6944.097267355211;6949.513534052568;6971.407430368476;7070.151581810215;7084.858302834017;7093;7120.643967801693;7135;6342.207224096988;6355.014972679242;6364.363563643598;6364.427201551883;6374.553781235269;6524.706388212447;6600.570962887397;6625.602463852184;6633.469322454289;6702.36327548882 10:11:53 INFO - PROCESS | 20660 | |4;prototype.html;348.44597090625905;353.129535694513;353.5739433982052;354.4046002715437;360.1787923534341;6216.254049514053;6231.563790534658;6234.688265586719;6263.718132684029;6334.271558770749;6051.87896242076;6177.598456100351;6188.350223226553;6196.442320191182;6220.688965551727;4787.54518320759;4789;4811;4816.6869153504995;4820.060088282787;4824.035192961404;4825.469198388175;4826.951730482685;4827.131116399047;4837.492063333352;4711.316859055435;4759.833405830796;4763.4998325175875;4780.593649539794;4785.21044027735;4719.480857105716;4743.407074115736;4750.477447480775;4755.881102972453;4764.523547645243;4159.771212583307;4165.75005499671;4177.874663760092;4187.727797693171;4195.3916682081235;5884.205632239678;5902.203202567642;5906.763729450817;5912.260967379078;5917.881642367129;5436.103042997901;5515.145152501369;5535.557155427556;5541.750621222055;5549.334079910436;6605.471562275006;6618.7021584028835;6636.435902948255;6644.867102657968;6655.500837437212;4597.057603191338;4603.447586289633;4611.5619016193405;4617.607503362218;4631.8147274109;6755.9324406755795;6872.003559483846;6918.5502942309095;6928.757493487704;6931.306869313079;4678.087772884255;4683.578477937002;4685;4693.389859318267;4694.906101877943;4728.71627702339;4755;4758.500357462417;4760.7619619018915;4762.976185119052;5478.424765399655;5500.944990550123;5502.532284755761;5516.14499752539;5520.585956053312;6556.377144171296;6612;6619.437347825488;6661.600303981777;6681.899771503431;1612.927418266181;1647.3328302037455;1659.7095508286002;1669.2571805546659;1697.6859281033048;1096.5339730614457;1113.9387333696725;1119.5465836336298;1128.3850301585655;1137.590467431724;6136.478399336106;6201.782937597162;6204.844878878064;6211.65835879031;6217.036359364306;6753.797386078426;6767.35710107539;6772.356626120511;6775.424088952395;6790.932090679129;6044.335123136451;6134.754609815646;6162;6171.105189747462;6171.59884607499;3630.981845090758;3652.397354436488;3674.430463278196;3677.0807298175455;3682.4108142697573;6918.827029324207;6922.134733158356;6929.133858267716;6935.618540980295;6949.339812717783;6845.623490707959;6987.231404545598;6991.860162796817;6995.510314277952;6995.755148569878;6957.06079679247;6959.851624482005;6974.302569743087;6974.686139123752;6989.679902046487;6762.4928130389435;6770.96614516944;6771.932280677327;6778.457723382019;6779.118714567075;6624.9337506624315;6654.434373078343;6665.0335701324;6692.364225398579;6712;6941.479389045943;6952.826179345355;6956.991236270611;6963.8607227854145;6972.09362782835;4611.446626404853;4651.395318608695;4661.254199328091;4664.86005419838;4669.276262179367;6731.764388246388;6792.456603471809;6797.4901882358035;6802.523823332319;6854.10896583441;6652.002199670088;6682.398584127452;6705.698243579148;6709.966450167718;6718.966405167943;6665.433438157811;6693.732250709917;6697.966510167418;6702.530822842355;6709.094272273181;6482.805515834532;6537.640429776408;6550.672466376567;6571.474282057519;6581.506387021088;6662.733490660319;6711.597304161766;6715.328467153246;6723.394894459522;6730.562513436611;6548.508861835287;6559;6560.737570497317;6568.6058836469965;6580.638064906476 10:11:53 INFO - PROCESS | 20660 | |5;yui.html;660.8149718078937;705.7917914215305;721.5598484924197;765.3226894198637;826.9834603307934;15348.462803801869;15607;15622.687546249068;15654.84345156548;15735.055896646209;14345.354459049342;14387.856121438783;14429.855701442983;14446.277686115678;14476;793.8809178623195;808.3290868579065;809.2595275323073;827.9296259817922;829.2039641943742;818.0183779464636;819.4755356571799;821.2157389692829;821.2895845093981;822.8272062866805;853.0999795216045;853.2619284319051;855.1363123245536;855.5722138930535;857.0229937870832;853.2320911179926;853.9444936079135;854.6196942360652;854.7222152800365;854.8290341931607;625.1060982794602;629.6033498895666;629.902365133405;630.533405280094;631.3654776949182;13036.739265214643;13228.933855330759;13292.667683307898;13312.86687133126;13337;11934.701632459171;12323.383830808514;12368.44342004612;12711.555095571703;12872.664274223487;9790.755231119208;9902.455364954925;9949.801003979952;10591.788164236672;11051.557937682483;3396.6603339666085;3397.3375191837604;3456.87900923469;3515.929681406383;3640.908977275563;41330;42381.576184238074;42399.36400953988;42473.36289955653;42479;8646.697365592174;8895.377323587287;8896.065913079034;9063.456192628464;9208.401453905608;15555.377784888478;15667.686646267239;15719.214039297989;15737.370505179893;15766.92116539433;6995.685194166274;7032.226455089936;7250.0574925260435;7326.340629343278;7619.228197630851;4301.376300436419;4311.461067366579;4322.562640779748;4344.587264209895;4447.332900064951;3093.876244950177;3109.176068341891;3115.2211947013247;3121.048080335474;3123.6251649801716;571.2944513525792;582.9970850145722;583.8511179649163;584.4535359438938;584.558658213055;551.1539786427815;589.8584339758427;674.3680293689283;678.9916973294653;702.3994484715597;8836.425632333878;8919.10808919103;8928.955355223183;8942.195202431813;9093.81812363749;515.9380874295109;577.0882006429831;593.6497466494789;711.0969069281983;716.759885438384;4034.293998550301;4246.766427846498;4335.002949321673;4415.955840441618;4459.420275364247;49757;50182.74908625506;54393.72803135959;54964;55043.17435238475;43709.56290437055;44517.77741111274;44629;45141.774291128335;45156.77421612871;43709.56290437055;43764.34353484637;44234;44526.10947781026;45177.32234016492;8791.956040219759;8878.911210887809;8966.575157493431;9180.17378435944;9260;30736.231594210323;30981.225469363446;31921.201969950936;32187;32313.838430807697;38449.6155038446;41451.1709765809;41995;42102.578974209864;42212.577874220864;10417.843732344172;10570.735731606772;10668.83996740065;10801.459927003776;11534.769304614028;12080.53024355808;12139.150259481752;12215.877841221474;12292.262464252173;12453.750924981268;10195.898041019494;10430.634927777795;10648.201384896009;10648.520816563117;10811.729706757395;10877.292975956538;10995.065419439437;11120.944395277971;11210.327380357205;11403.714907127389;11242.325460472397;11259.887401126212;11275.436228188722;11766.058715302926;11773.293602383885;9015.098490150933;9365.344425890122;9723.9027609723;9761.902380976384;9983.500824958868;8664.653413863627;9225.72322830316;10104.141148002502;10135;10157.796844063225 10:11:53 INFO - PROCESS | 20660 | __end_tp_report 10:11:53 INFO - PROCESS | 20660 | __start_cc_report 10:11:53 INFO - PROCESS | 20660 | _x_x_mozilla_cycle_collect,310 10:11:53 INFO - PROCESS | 20660 | __end_cc_report 10:11:53 INFO - PROCESS | 20660 | __startTimestamp1452535913917__endTimestamp 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | ------- Summary: start ------- 10:11:53 INFO - PROCESS | 20660 | Number of tests: 6 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | [#0] dojo.html Cycles:165 Average:5372.36 Median:5603.05 stddev:592.69 (10.6%) stddev-sans-first:569.72 10:11:53 INFO - PROCESS | 20660 | Values: 3210.4 3226.9 3263.0 3267.1 3280.1 5254.6 5282.4 5287.2 5295.3 5315.5 5256.9 5303.9 5306.2 5312.5 5314.0 4880.6 4919.6 4925.6 4999.5 5012.8 4925.6 4974.4 4976.4 5029.9 5056.3 4599.0 4842.1 4920.0 4937.3 4941.5 4901.5 4930.2 4941.5 4964.2 4978.9 4801.3 4879.7 4906.1 4923.6 4992.4 5188.7 5241.2 5243.7 5259.7 5311.5 5830.7 5867.4 5869.1 5869.9 5871.0 5737.8 5786.0 5867.2 5911.3 5924.3 5474.2 5491.1 5495.5 5509.1 5555.1 5964.0 5972.4 5973.2 5973.9 5974.2 5682.0 5725.2 5733.7 5746.9 5791.5 5712.2 5715.5 5735.6 5736.6 5760.0 5616.1 5665.2 5671.7 5672.8 5704.4 5588.1 5678.8 5730.9 5743.3 5857.5 4469.3 4474.5 4487.6 4492.5 4500.3 3977.8 3978.4 3981.6 4048.7 4068.9 5346.5 5374.7 5416.0 5444.1 5454.0 5762.2 5821.9 5826.5 5835.5 5836.8 5283.0 5330.1 5395.6 5397.5 5399.6 4898.5 4917.8 4938.5 4956.1 4960.6 5856.5 5927.6 5931.0 5933.7 5944.9 5630.3 5735.1 5813.2 5828.1 5831.0 5875.5 5950.1 5964.2 5971.8 6013.1 5667.5 5690.6 5698.3 5702.0 5726.4 5714.4 5833.9 5840.3 5848.6 5860.8 5601.3 5617.7 5716.2 5785.4 5825.3 5724.1 5732.5 5752.4 5754.1 5757.9 5581.1 5610.8 5641.9 5663.0 5665.5 5592.9 5629.3 5661.2 5735.9 5779.0 5572.2 5596.6 5600.4 5603.0 5608.8 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | [#1] ext.html Cycles:180 Average:48271.49 Median:20652.47 stddev:85345.14 (413.2%) stddev-sans-first:85509.25 10:11:53 INFO - PROCESS | 20660 | Values: 520.4 532.5 533.6 552.7 554.5 36031.3 36777.6 36789.8 36801.8 36854.4 39742.4 40759.0 40791.6 40793.0 40861.4 8342.2 8456.1 8460.0 8489.8 8523.4 8314.8 8367.9 8451.0 8609.0 8610.4 8559.7 8590.5 8628.4 8631.9 8666.5 8420.1 8421.6 8487.4 8626.1 8641.1 8527.2 8601.4 8669.0 8678.7 8683.0 39387.4 40094.2 40252.0 40268.6 40370.4 3107.6 3353.9 3752.6 3755.9 3862.0 30006.1 30742.1 30811.2 30950.8 31148.7 3567.3 3613.2 3619.8 3785.7 3855.2 265385.0 265565.0 266150.0 266583.0 267102.0 42419.4 59460.0 59700.7 59922.0 60109.0 42752.0 43099.8 43567.1 43675.0 43679.3 15299.3 15433.7 15585.6 15594.2 15624.2 12409.6 12474.1 12515.9 12517.6 12519.1 13907.1 14134.5 14194.6 14218.8 14269.6 5800.0 5804.4 5835.2 5867.7 5914.3 911.9 922.5 965.6 1015.0 1067.7 29013.0 31331.8 31449.7 32089.8 32346.5 1032.4 1048.9 1049.8 1103.6 1109.7 14587.0 15017.4 15117.5 15337.5 15580.0 396218.0 396932.0 398422.0 399383.0 399386.0 54212.5 54602.5 54690.5 54731.5 54877.7 1368.5 1369.1 1381.6 1392.5 1395.1 28537.0 29249.4 29362.3 29397.6 29723.1 46555.8 46725.6 46900.5 47250.3 47625.3 293811.0 294246.0 295832.0 295930.0 296693.0 32314.4 41973.4 43708.0 44213.1 44385.3 39393.4 40406.2 41413.2 41505.8 42147.8 34719.7 35550.5 35587.8 36414.0 38464.6 36625.2 36954.4 37549.0 38052.8 38247.0 35063.0 36135.3 36140.8 36180.0 36581.5 32072.7 32369.2 34175.5 34397.7 34701.5 25630.7 25764.6 25782.5 26033.0 26168.3 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | [#2] jquery.html Cycles:180 Average:26972.21 Median:4402.24 stddev:86460.61 (1964.0%) stddev-sans-first:86680.05 10:11:53 INFO - PROCESS | 20660 | Values: 358.8 359.9 360.5 360.9 364.0 13354.5 13599.9 16163.7 16743.7 17628.0 15385.9 15679.7 16133.4 16188.8 16225.2 4894.8 5325.5 5338.5 5349.4 5356.5 4908.5 5114.9 5126.9 5128.2 5184.7 4861.9 5113.4 5142.2 5152.5 5159.0 5194.7 5315.5 5352.8 5365.0 5376.2 5117.2 5164.6 5167.1 5173.8 5174.2 19722.8 19880.1 20002.6 20494.0 20665.7 1982.6 2030.0 2052.0 2060.9 2287.1 8799.3 8959.3 9055.5 9182.5 9326.9 1700.8 1754.0 1762.6 1765.7 1773.4 50883.5 51672.5 53149.7 53436.7 54111.2 9800.8 10173.8 10270.1 10270.2 10305.3 13157.7 13220.5 13245.6 13253.5 13298.3 7442.9 7627.4 7630.6 7635.4 7640.0 7346.3 7351.2 7363.7 7388.4 7397.5 4224.3 4253.3 4385.1 4419.4 4447.5 1806.3 1869.5 1871.5 1874.9 1879.2 810.5 897.7 946.9 997.3 1047.6 16098.6 16141.9 16213.7 16576.6 16649.9 883.7 943.5 1005.6 1027.8 1044.2 9289.8 9354.8 9473.5 9650.9 9739.9 520276.0 526672.0 528098.0 532987.0 540965.0 42550.0 42936.6 74949.9 75269.0 78426.0 1124.2 1136.6 1143.6 1153.2 1159.0 15055.7 15115.2 15203.4 15264.5 15281.9 33736.0 34268.7 34734.0 34847.3 35149.8 44857.0 44956.3 46528.5 46735.5 47617.8 6806.7 6983.4 7203.8 7244.1 7397.6 10538.9 10543.9 10725.2 11188.3 11262.7 9580.2 9653.0 9838.8 9846.5 10154.8 10034.2 10367.3 10641.5 10641.6 10700.9 10123.8 10287.4 10401.0 10585.6 10686.8 7354.8 7533.6 7574.7 7575.8 7609.5 8123.7 8851.7 9421.9 10320.1 10375.1 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | [#3] mootools.html Cycles:180 Average:5512.98 Median:6369.49 stddev:2854.92 (44.8%) stddev-sans-first:2846.54 10:11:53 INFO - PROCESS | 20660 | Values: 1443.1 1489.4 1657.6 1793.5 1826.0 7474.4 7618.2 7677.9 7784.6 7945.2 7963.3 8008.6 8082.0 8096.4 8109.6 2348.7 2370.7 2375.2 2376.8 2382.3 2404.0 2422.5 2434.4 2434.5 2435.9 2316.4 2363.2 2381.9 2392.7 2400.0 2353.6 2355.0 2372.0 2393.9 2400.8 2411.3 2420.7 2429.1 2438.5 2440.8 7845.1 7848.9 7861.4 7865.5 7917.4 4975.0 5036.2 5052.7 5060.8 5112.2 3057.2 3059.7 3114.8 3137.5 3143.0 995.7 1002.7 1020.0 1029.2 1053.4 10978.7 11027.9 11082.3 11125.8 11136.1 4357.2 4367.5 4477.5 4480.0 4494.5 8875.9 8876.5 8878.7 8887.3 8898.2 4812.3 4815.2 4861.4 4882.5 4897.0 4416.7 4437.3 4443.1 4474.1 4504.8 3497.7 3589.9 3611.6 3630.7 3639.5 1063.4 1090.6 1111.9 1113.1 1148.8 990.1 1060.0 1145.7 1148.7 1341.8 7177.4 7188.9 7225.2 7230.7 7254.5 607.8 616.0 616.8 617.2 759.4 5253.2 5275.4 5317.6 5322.8 5366.9 9126.8 9275.7 9289.6 9352.9 9415.3 9225.3 9229.3 9261.6 9271.2 9303.8 7304.3 7481.5 7492.6 7514.1 7540.5 7292.8 7389.0 7395.4 7425.6 7449.6 8513.3 8524.9 8640.4 8684.8 8743.0 8507.8 8885.6 8887.5 8921.5 8985.1 6801.7 6861.6 6902.2 6902.6 6931.5 7232.9 7336.2 7378.4 7428.7 7455.7 7068.1 7219.5 7236.7 7314.7 7454.9 6842.6 6867.9 6944.1 6949.5 6971.4 7070.2 7084.9 7093.0 7120.6 7135.0 6342.2 6355.0 6364.4 6364.4 6374.6 6524.7 6600.6 6625.6 6633.5 6702.4 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | [#4] prototype.html Cycles:180 Average:5518.63 Median:6203.31 stddev:1656.01 (26.7%) stddev-sans-first:1614.54 10:11:53 INFO - PROCESS | 20660 | Values: 348.4 353.1 353.6 354.4 360.2 6216.3 6231.6 6234.7 6263.7 6334.3 6051.9 6177.6 6188.4 6196.4 6220.7 4787.5 4789.0 4811.0 4816.7 4820.1 4824.0 4825.5 4827.0 4827.1 4837.5 4711.3 4759.8 4763.5 4780.6 4785.2 4719.5 4743.4 4750.5 4755.9 4764.5 4159.8 4165.8 4177.9 4187.7 4195.4 5884.2 5902.2 5906.8 5912.3 5917.9 5436.1 5515.1 5535.6 5541.8 5549.3 6605.5 6618.7 6636.4 6644.9 6655.5 4597.1 4603.4 4611.6 4617.6 4631.8 6755.9 6872.0 6918.6 6928.8 6931.3 4678.1 4683.6 4685.0 4693.4 4694.9 4728.7 4755.0 4758.5 4760.8 4763.0 5478.4 5500.9 5502.5 5516.1 5520.6 6556.4 6612.0 6619.4 6661.6 6681.9 1612.9 1647.3 1659.7 1669.3 1697.7 1096.5 1113.9 1119.5 1128.4 1137.6 6136.5 6201.8 6204.8 6211.7 6217.0 6753.8 6767.4 6772.4 6775.4 6790.9 6044.3 6134.8 6162.0 6171.1 6171.6 3631.0 3652.4 3674.4 3677.1 3682.4 6918.8 6922.1 6929.1 6935.6 6949.3 6845.6 6987.2 6991.9 6995.5 6995.8 6957.1 6959.9 6974.3 6974.7 6989.7 6762.5 6771.0 6771.9 6778.5 6779.1 6624.9 6654.4 6665.0 6692.4 6712.0 6941.5 6952.8 6957.0 6963.9 6972.1 4611.4 4651.4 4661.3 4664.9 4669.3 6731.8 6792.5 6797.5 6802.5 6854.1 6652.0 6682.4 6705.7 6710.0 6719.0 6665.4 6693.7 6698.0 6702.5 6709.1 6482.8 6537.6 6550.7 6571.5 6581.5 6662.7 6711.6 6715.3 6723.4 6730.6 6548.5 6559.0 6560.7 6568.6 6580.6 10:11:53 INFO - PROCESS | 20660 | 10:11:53 INFO - PROCESS | 20660 | [#5] yui.html Cycles:180 Average:13051.01 Median:24324.98 stddev:14393.93 (59.2%) stddev-sans-first:14404.23 10:11:53 INFO - PROCESS | 20660 | Values: 660.8 705.8 721.6 765.3 827.0 15348.5 15607.0 15622.7 15654.8 15735.1 14345.4 14387.9 14429.9 14446.3 14476.0 793.9 808.3 809.3 827.9 829.2 818.0 819.5 821.2 821.3 822.8 853.1 853.3 855.1 855.6 857.0 853.2 853.9 854.6 854.7 854.8 625.1 629.6 629.9 630.5 631.4 13036.7 13228.9 13292.7 13312.9 13337.0 11934.7 12323.4 12368.4 12711.6 12872.7 9790.8 9902.5 9949.8 10591.8 11051.6 3396.7 3397.3 3456.9 3515.9 3640.9 41330.0 42381.6 42399.4 42473.4 42479.0 8646.7 8895.4 8896.1 9063.5 9208.4 15555.4 15667.7 15719.2 15737.4 15766.9 6995.7 7032.2 7250.1 7326.3 7619.2 4301.4 4311.5 4322.6 4344.6 4447.3 3093.9 3109.2 3115.2 3121.0 3123.6 571.3 583.0 583.9 584.5 584.6 551.2 589.9 674.4 679.0 702.4 8836.4 8919.1 8929.0 8942.2 9093.8 515.9 577.1 593.6 711.1 716.8 4034.3 4246.8 4335.0 4416.0 4459.4 49757.0 50182.7 54393.7 54964.0 55043.2 43709.6 44517.8 44629.0 45141.8 45156.8 43709.6 43764.3 44234.0 44526.1 45177.3 8792.0 8878.9 8966.6 9180.2 9260.0 30736.2 30981.2 31921.2 32187.0 32313.8 38449.6 41451.2 41995.0 42102.6 42212.6 10417.8 10570.7 10668.8 10801.5 11534.8 12080.5 12139.2 12215.9 12292.3 12453.8 10195.9 10430.6 10648.2 10648.5 10811.7 10877.3 10995.1 11120.9 11210.3 11403.7 11242.3 11259.9 11275.4 11766.1 11773.3 9015.1 9365.3 9723.9 9761.9 9983.5 8664.7 9225.7 10104.1 10135.0 10157.8 10:11:53 INFO - PROCESS | 20660 | -------- Summary: end -------- 10:11:53 INFO - PROCESS | 20660 | 10:11:54 INFO - TEST-INFO | 20660: exit 0 10:11:54 INFO - TEST-OK | dromaeo_css | took 1112150ms 10:11:54 INFO - TEST-START | kraken 10:11:54 INFO - operating with platform_type : linux_ 10:11:54 INFO - Initialising browser for kraken test... 10:11:54 INFO - TEST-INFO | started process 20903 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpd4l49D/profile http://localhost:56195/getInfo.html) 10:11:58 INFO - PROCESS | 20903 | 10:11:58 INFO - PROCESS | 20903 | (process:20977): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:11:59 INFO - PROCESS | 20903 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 10:12:00 INFO - PROCESS | 20903 | __metrics Screen width/height:1600/1200 10:12:00 INFO - PROCESS | 20903 | colorDepth:24 10:12:00 INFO - PROCESS | 20903 | Browser inner width/height: 1024/697 10:12:00 INFO - PROCESS | 20903 | __metrics 10:12:00 INFO - PROCESS | 20903 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:12:00 INFO - PROCESS | 20903 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:12:01 INFO - TEST-INFO | 20903: exit 0 10:12:01 INFO - Browser initialized. 10:12:01 INFO - Running cycle 1/1 for kraken test... 10:12:01 INFO - TEST-INFO | started process 21026 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpd4l49D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:02 INFO - PROCESS | 21026 | 10:12:02 INFO - PROCESS | 21026 | (process:21087): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:12:12 INFO - PROCESS | 21026 | RSS: Main: 150528000 10:12:12 INFO - PROCESS | 21026 | 10:12:15 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56195/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:16 INFO - PROCESS | 21026 | RSS: Main: 151457792 10:12:16 INFO - PROCESS | 21026 | 10:12:18 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56195/tests/kraken/driver.html?testName=audio-dft) 10:12:19 INFO - PROCESS | 21026 | RSS: Main: 152354816 10:12:19 INFO - PROCESS | 21026 | 10:12:22 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56195/tests/kraken/driver.html?testName=audio-fft) 10:12:22 INFO - PROCESS | 21026 | RSS: Main: 147320832 10:12:22 INFO - PROCESS | 21026 | 10:12:24 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56195/tests/kraken/driver.html?testName=audio-oscillator) 10:12:25 INFO - PROCESS | 21026 | RSS: Main: 147308544 10:12:25 INFO - PROCESS | 21026 | 10:12:27 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:28 INFO - PROCESS | 21026 | RSS: Main: 146935808 10:12:28 INFO - PROCESS | 21026 | 10:12:31 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56195/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:31 INFO - PROCESS | 21026 | RSS: Main: 148189184 10:12:31 INFO - PROCESS | 21026 | 10:12:35 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56195/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:35 INFO - PROCESS | 21026 | RSS: Main: 147169280 10:12:35 INFO - PROCESS | 21026 | 10:12:38 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56195/tests/kraken/driver.html?testName=json-parse-financial) 10:12:39 INFO - PROCESS | 21026 | RSS: Main: 148570112 10:12:39 INFO - PROCESS | 21026 | 10:12:40 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:41 INFO - PROCESS | 21026 | RSS: Main: 149512192 10:12:41 INFO - PROCESS | 21026 | 10:12:43 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:43 INFO - PROCESS | 21026 | RSS: Main: 148807680 10:12:43 INFO - PROCESS | 21026 | 10:12:45 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:46 INFO - PROCESS | 21026 | RSS: Main: 149381120 10:12:46 INFO - PROCESS | 21026 | 10:12:49 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:49 INFO - PROCESS | 21026 | RSS: Main: 149528576 10:12:49 INFO - PROCESS | 21026 | 10:12:52 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:52 INFO - PROCESS | 21026 | RSS: Main: 149618688 10:12:52 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | Cycle 1(1): loaded http://localhost:56195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56195/tests/kraken/driver.html?testName=ai-astar) 10:12:54 INFO - PROCESS | 21026 | RSS: Main: 150298624 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | __start_tp_report 10:12:54 INFO - PROCESS | 21026 | _x_x_mozilla_page_load 10:12:54 INFO - PROCESS | 21026 | _x_x_mozilla_page_load_details 10:12:54 INFO - PROCESS | 21026 | |i|pagename|runs| 10:12:54 INFO - PROCESS | 21026 | |0;ai-astar;111;108;114;111;111;124;111;111;111;110 10:12:54 INFO - PROCESS | 21026 | |1;audio-beat-detection;149;127;153;171;128;155;151;128;168;127 10:12:54 INFO - PROCESS | 21026 | |2;audio-dft;161;163;163;162;162;162;163;171;168;162 10:12:54 INFO - PROCESS | 21026 | |3;audio-fft;70;74;74;73;74;73;136;71;71;73 10:12:54 INFO - PROCESS | 21026 | |4;audio-oscillator;98;97;142;97;98;97;140;96;96;145 10:12:54 INFO - PROCESS | 21026 | |5;imaging-gaussian-blur;110;110;110;109;110;110;109;111;110;109 10:12:54 INFO - PROCESS | 21026 | |6;imaging-darkroom;148;149;145;147;148;147;146;146;147;148 10:12:54 INFO - PROCESS | 21026 | |7;imaging-desaturate;96;101;95;96;98;96;97;97;96;96 10:12:54 INFO - PROCESS | 21026 | |8;json-parse-financial;59;60;63;58;60;59;60;61;58;56 10:12:54 INFO - PROCESS | 21026 | |9;json-stringify-tinderbox;68;70;68;67;67;69;68;69;69;69 10:12:54 INFO - PROCESS | 21026 | |10;stanford-crypto-aes;87;85;96;87;95;86;87;89;87;88 10:12:54 INFO - PROCESS | 21026 | |11;stanford-crypto-ccm;125;122;126;121;124;132;128;122;129;123 10:12:54 INFO - PROCESS | 21026 | |12;stanford-crypto-pbkdf2;147;153;152;152;154;142;151;150;142;150 10:12:54 INFO - PROCESS | 21026 | |13;stanford-crypto-sha256-iterative;68;70;71;68;82;69;68;69;68;67 10:12:54 INFO - PROCESS | 21026 | __end_tp_report 10:12:54 INFO - PROCESS | 21026 | __start_cc_report 10:12:54 INFO - PROCESS | 21026 | _x_x_mozilla_cycle_collect,763 10:12:54 INFO - PROCESS | 21026 | __end_cc_report 10:12:54 INFO - PROCESS | 21026 | __startTimestamp1452535974790__endTimestamp 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | ------- Summary: start ------- 10:12:54 INFO - PROCESS | 21026 | Number of tests: 14 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#0] ai-astar Cycles:10 Average:112.20 Median:111.00 stddev:4.39 (4.0%) stddev-sans-first:4.64 10:12:54 INFO - PROCESS | 21026 | Values: 111.0 108.0 114.0 111.0 111.0 124.0 111.0 111.0 111.0 110.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.00 stddev:17.13 (11.3%) stddev-sans-first:18.13 10:12:54 INFO - PROCESS | 21026 | Values: 149.0 127.0 153.0 171.0 128.0 155.0 151.0 128.0 168.0 127.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.20 (2.0%) stddev-sans-first:3.24 10:12:54 INFO - PROCESS | 21026 | Values: 161.0 163.0 163.0 162.0 162.0 162.0 163.0 171.0 168.0 162.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:20.11 (27.6%) stddev-sans-first:21.07 10:12:54 INFO - PROCESS | 21026 | Values: 70.0 74.0 74.0 73.0 74.0 73.0 136.0 71.0 71.0 73.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:97.00 stddev:21.94 (22.6%) stddev-sans-first:22.79 10:12:54 INFO - PROCESS | 21026 | Values: 98.0 97.0 142.0 97.0 98.0 97.0 140.0 96.0 96.0 145.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 10:12:54 INFO - PROCESS | 21026 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 109.0 111.0 110.0 109.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.20 (0.8%) stddev-sans-first:1.22 10:12:54 INFO - PROCESS | 21026 | Values: 148.0 149.0 145.0 147.0 148.0 147.0 146.0 146.0 147.0 148.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.69 (1.8%) stddev-sans-first:1.76 10:12:54 INFO - PROCESS | 21026 | Values: 96.0 101.0 95.0 96.0 98.0 96.0 97.0 97.0 96.0 96.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.00 stddev:1.90 (3.2%) stddev-sans-first:2.01 10:12:54 INFO - PROCESS | 21026 | Values: 59.0 60.0 63.0 58.0 60.0 59.0 60.0 61.0 58.0 56.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 10:12:54 INFO - PROCESS | 21026 | Values: 68.0 70.0 68.0 67.0 67.0 69.0 68.0 69.0 69.0 69.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:87.50 stddev:3.74 (4.3%) stddev-sans-first:3.92 10:12:54 INFO - PROCESS | 21026 | Values: 87.0 85.0 96.0 87.0 95.0 86.0 87.0 89.0 87.0 88.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:125.50 stddev:3.55 (2.8%) stddev-sans-first:3.77 10:12:54 INFO - PROCESS | 21026 | Values: 125.0 122.0 126.0 121.0 124.0 132.0 128.0 122.0 129.0 123.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:151.50 stddev:4.30 (2.8%) stddev-sans-first:4.48 10:12:54 INFO - PROCESS | 21026 | Values: 147.0 153.0 152.0 152.0 154.0 142.0 151.0 150.0 142.0 150.0 10:12:54 INFO - PROCESS | 21026 | 10:12:54 INFO - PROCESS | 21026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.00 stddev:4.37 (6.3%) stddev-sans-first:4.58 10:12:54 INFO - PROCESS | 21026 | Values: 68.0 70.0 71.0 68.0 82.0 69.0 68.0 69.0 68.0 67.0 10:12:54 INFO - PROCESS | 21026 | -------- Summary: end -------- 10:12:54 INFO - PROCESS | 21026 | 10:12:55 INFO - TEST-INFO | 21026: exit 0 10:12:55 INFO - TEST-OK | kraken | took 61075ms 10:12:55 INFO - TEST-START | v8_7 10:12:55 INFO - operating with platform_type : linux_ 10:12:55 INFO - Initialising browser for v8_7 test... 10:12:55 INFO - TEST-INFO | started process 21316 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpct866I/profile http://localhost:56195/getInfo.html) 10:12:59 INFO - PROCESS | 21316 | 10:12:59 INFO - PROCESS | 21316 | (process:21390): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:13:00 INFO - PROCESS | 21316 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 10:13:00 INFO - PROCESS | 21316 | __metrics Screen width/height:1600/1200 10:13:00 INFO - PROCESS | 21316 | colorDepth:24 10:13:00 INFO - PROCESS | 21316 | Browser inner width/height: 1024/697 10:13:00 INFO - PROCESS | 21316 | __metrics 10:13:01 INFO - PROCESS | 21316 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:13:02 INFO - TEST-INFO | 21316: exit 0 10:13:02 INFO - Browser initialized. 10:13:02 INFO - Running cycle 1/1 for v8_7 test... 10:13:02 INFO - TEST-INFO | started process 21439 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpct866I/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:03 INFO - PROCESS | 21439 | 10:13:03 INFO - PROCESS | 21439 | (process:21497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:13:13 INFO - PROCESS | 21439 | RSS: Main: 150376448 10:13:13 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | Cycle 1(1): loaded http://localhost:56195/tests/v8_7/run.html (next: http://localhost:56195/tests/v8_7/run.html) 10:13:36 INFO - PROCESS | 21439 | RSS: Main: 147394560 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | __start_tp_report 10:13:36 INFO - PROCESS | 21439 | _x_x_mozilla_page_load 10:13:36 INFO - PROCESS | 21439 | _x_x_mozilla_page_load_details 10:13:36 INFO - PROCESS | 21439 | |i|pagename|runs| 10:13:36 INFO - PROCESS | 21439 | |0;Richards;166.333998669328 10:13:36 INFO - PROCESS | 21439 | |1;DeltaBlue;196.8503937007874 10:13:36 INFO - PROCESS | 21439 | |2;Encrypt;282.88543140028287 10:13:36 INFO - PROCESS | 21439 | |3;Decrypt;5218.75 10:13:36 INFO - PROCESS | 21439 | |4;RayTrace;1066.0980810234541 10:13:36 INFO - PROCESS | 21439 | |5;Earley;731.528895391368 10:13:36 INFO - PROCESS | 21439 | |6;Boyer;12407.407407407407 10:13:36 INFO - PROCESS | 21439 | |7;RegExp;40900 10:13:36 INFO - PROCESS | 21439 | |8;Splay;581.7335660267597 10:13:36 INFO - PROCESS | 21439 | |9;NavierStokes;4835.748792270531 10:13:36 INFO - PROCESS | 21439 | __end_tp_report 10:13:36 INFO - PROCESS | 21439 | __startTimestamp1452536016535__endTimestamp 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | ------- Summary: start ------- 10:13:36 INFO - PROCESS | 21439 | Number of tests: 10 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 166.3 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#1] DeltaBlue Cycles:1 Average:196.85 Median:196.85 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 196.9 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 282.9 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 5218.8 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 1066.1 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#5] Earley Cycles:1 Average:731.53 Median:731.53 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 731.5 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 12407.4 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#7] RegExp Cycles:1 Average:40900.00 Median:40900.00 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 40900.0 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#8] Splay Cycles:1 Average:581.73 Median:581.73 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 581.7 10:13:36 INFO - PROCESS | 21439 | 10:13:36 INFO - PROCESS | 21439 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:13:36 INFO - PROCESS | 21439 | Values: 4835.7 10:13:36 INFO - PROCESS | 21439 | -------- Summary: end -------- 10:13:36 INFO - PROCESS | 21439 | 10:13:37 INFO - TEST-INFO | 21439: exit 0 10:13:37 INFO - TEST-OK | v8_7 | took 41664ms 10:13:37 INFO - SUITE-END | took 1214s 10:13:37 INFO - Completed test suite (00:20:15) 10:13:37 INFO - Working with test: dromaeo_css 10:13:37 INFO - Generating results file: dromaeo_css 10:13:37 INFO - Working with test: kraken 10:13:37 INFO - Generating results file: kraken 10:13:37 INFO - javascript benchmark 10:13:37 INFO - Working with test: v8_7 10:13:37 INFO - Generating results file: v8_7 10:13:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:13:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 10:13:37 INFO - process_Request line: dromaeo_css 6915.82 graph.html#tests=[[72,63,43]] 10:13:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:13:37 INFO - process_Request line: kraken 1525.80 graph.html#tests=[[232,63,43]] 10:13:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:13:37 INFO - process_Request line: v8_7 20276.54 graph.html#tests=[[230,63,43]] 10:13:37 INFO - RETURN: dromaeo_css: 6915.82 10:13:37 INFO - RETURN: kraken: 1525.80 10:13:37 INFO - RETURN: v8_7: 20276.54 10:13:37 INFO - javascript benchmark 10:13:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3210.406074876148, 3226.9193270168257, 3262.983685081574, 3267.0688853676706, 3280.147161737949, 5254.553362964152, 5282.418933917266, 5287.2069189621525, 5295.338082739658, 5315.468453154683, 5256.947430525694, 5303.893922121565, 5306.230596563506, 5312.548433383167, 5314.016906872222, 4880.6095512358925, 4919.60643148549, 4925.630577706668, 4999.450060493343, 5012.799488020475, 4925.556699897009, 4974.3533340665845, 4976.377952755905, 5029.924551131736, 5056.29211910331, 4598.954010459886, 4842.104210721028, 4919.975400123012, 4937.259411088366, 4941.481144479814, 4901.534354236342, 4930.186519224324, 4941.481144479814, 4964.156093464084, 4978.850634480971, 4801.2798080287885, 4879.731614761186, 4906.092372910987, 4923.556879880828, 4992.375953005874, 5188.740562971874, 5241.240020197089, 5243.68537887728, 5259.658122222043, 5311.548518375943, 5830.650160990354, 5867.354590994987, 5869.148973398876, 5869.85325366865, 5871.0, 5737.827865164052, 5786.0, 5867.178594996704, 5911.290645122613, 5924.289085309747, 5474.233607294982, 5491.121420572689, 5495.53287970523, 5509.090999984997, 5555.138953462219, 5963.970180149072, 5972.372900845348, 5973.223480947449, 5973.850653733692, 5974.1636170935235, 5681.971590142106, 5725.198472213893, 5733.741981610838, 5746.913796293059, 5791.507721843691, 5712.171735098387, 5715.514181294553, 5735.569832262597, 5736.627119237236, 5759.971200143972, 5616.1014237721765, 5665.178549110438, 5671.716414179275, 5672.801451949162, 5704.4295570443455, 5588.0779671354585, 5678.801241956512, 5730.88247791685, 5743.282089738783, 5857.531397488191, 4469.329600559942, 4474.530174331713, 4487.618552423015, 4492.505824359318, 4500.279955207151, 3977.8209980550946, 3978.4430179774854, 3981.6217459341315, 4048.6963477739287, 4068.9186216276103, 5346.518813306821, 5374.704391258519, 5416.0, 5444.128939369682, 5454.045542030129, 5762.164486149485, 5821.854453638693, 5826.504747096459, 5835.503982161564, 5836.766529338864, 5283.0, 5330.067238233293, 5395.595330350239, 5397.541208997279, 5399.622026458111, 4898.53463920927, 4917.7786999585105, 4938.481459446706, 4956.107900577858, 4960.578350840146, 5856.531477481876, 5927.585069045212, 5931.0213814720955, 5933.6736479493175, 5944.851378715567, 5630.324361076697, 5735.11105778605, 5813.215215945793, 5828.067509198508, 5831.0, 5875.500582450369, 5950.077737950624, 5964.224650795369, 5971.820845374646, 6013.128096426081, 5667.546596272371, 5690.630109042899, 5698.344690360662, 5701.971490142523, 5726.4273572642405, 5714.3714191438075, 5833.854153646193, 5840.2991641003355, 5848.590598658223, 5860.765569377178, 5601.271834661468, 5617.662940223599, 5716.171155182558, 5785.392533783892, 5825.330087040044, 5724.0555308375315, 5732.512736417451, 5752.424757524214, 5754.05058165398, 5757.91363129545, 5581.134924086773, 5610.831675049755, 5641.943580564306, 5662.971685141712, 5665.546756259571, 5592.944070559242, 5629.324481062299, 5661.207430959586, 5735.942640573541, 5778.971105144616, 5572.247746554163, 5596.552275817843, 5600.439956004367, 5603.047481928001, 5608.831735047955], "unit": "score", "name": "dojo.html", "value": 5334.292535878844}, {"lowerIsBetter": false, "replicates": [520.3599572525793, 532.5207313417924, 533.5758072332496, 552.6766841397782, 554.4510934175165, 36031.27937441253, 36777.632223677756, 36789.81605091971, 36801.81599092008, 36854.447183292235, 39742.40386394199, 40759.0, 40791.59208407915, 40793.0, 40861.38707919376, 8342.249197572202, 8456.112108228639, 8459.984801823759, 8489.830203395928, 8523.445976011539, 8314.750557483256, 8367.916320836775, 8451.0, 8608.956955215215, 8610.397272190949, 8559.700410485635, 8590.484570925764, 8628.396012279143, 8631.913680863174, 8666.480011199317, 8420.115887831782, 8421.578921053922, 8487.40588158829, 8626.137386261387, 8641.092685268019, 8527.232549070613, 8601.397902146853, 8669.046404895456, 8678.652853885837, 8682.956585217096, 39387.40918886219, 40094.198116037514, 40252.0, 40268.597314026774, 40370.394444083366, 3107.6115485564305, 3353.8658453661824, 3752.6434988676033, 3755.9436608450897, 3861.9806900965596, 30006.099817005525, 30742.07773766768, 30811.229719256975, 30950.845245773853, 31148.688513114805, 3567.340042092221, 3613.1870329175986, 3619.819009049537, 3785.6968148033493, 3855.151866589346, 265385.0, 265565.0, 266150.0, 266583.0, 267102.0, 42419.363709544385, 59460.0, 59700.70149649224, 59922.0, 60109.0, 42752.0, 43099.784501077294, 43567.12865742667, 43675.0, 43679.344809827875, 15299.311530981133, 15433.691326173413, 15585.610359741097, 15594.220288985505, 15624.21878906073, 12409.62771116868, 12474.126811123317, 12515.937420313023, 12517.561885334151, 12519.061070419755, 13907.122538457179, 14134.50529231472, 14194.645133871529, 14218.786718199235, 14269.571912842632, 5800.0, 5804.390538993429, 5835.1968692596, 5867.70661466925, 5914.319853216849, 911.9316051296179, 922.524899676667, 965.5944503308486, 1014.9949250253701, 1067.7223921780237, 29013.0, 31331.84334078315, 31449.685503145134, 32089.839550802095, 32346.514802277983, 1032.4218437674926, 1048.9003544663244, 1049.8425236214475, 1103.6358001859367, 1109.7170221593442, 14587.0, 15017.399304027716, 15117.54647360581, 15337.53987380358, 15580.0, 396218.0, 396932.0, 398422.0, 399383.0, 399386.0, 54212.45787542074, 54602.45397546053, 54690.45309546933, 54731.452685472635, 54877.72561137169, 1368.5278578890268, 1369.103237379518, 1381.6407733989236, 1392.5195807446414, 1395.1001603965587, 28537.0, 29249.41501170007, 29362.265943350732, 29397.559036614897, 29723.108306750833, 46555.767221165035, 46725.59823205309, 46900.530994689616, 47250.291245632034, 47625.28562071641, 293811.0, 294246.0, 295832.0, 295930.0, 296693.0, 32314.35371292608, 41973.38292787852, 43708.0, 44213.11573768571, 44385.33421998608, 39393.40909886411, 40406.19187616173, 41413.1717365657, 41505.79247103745, 42147.7892610535, 34719.65280347164, 35550.46674299836, 35587.82206088953, 36414.0, 38464.6153538461, 36625.16874156335, 36954.44568331423, 37549.0, 38052.809735951145, 38247.0, 35063.0, 36135.27729445449, 36140.8192959044, 36180.0, 36581.45127823031, 32072.67927320697, 32369.190770230933, 34175.487367689006, 34397.656023440446, 34701.47947780836, 25630.743692562835, 25764.61353079743, 25782.484350312512, 26033.0, 26168.34579135537], "unit": "score", "name": "ext.html", "value": 18272.220098462825}, {"lowerIsBetter": false, "replicates": [358.77935069931993, 359.88663570975143, 360.50070652146786, 360.88451695457445, 364.03167574252495, 13354.532591359304, 13599.864001360009, 16163.676726465479, 16743.66512669746, 17628.0, 15385.92307038466, 15679.686406271867, 16133.43532976346, 16188.838111618881, 16225.188740562984, 4894.804207831682, 5325.547328477084, 5338.546223571001, 5349.438308977559, 5356.464353564651, 4908.533689299511, 5114.948850511503, 5126.948730512703, 5128.205128205134, 5184.688918664873, 4861.927071093936, 5113.437521872591, 5142.228665700156, 5152.510511501401, 5159.0, 5194.662346947436, 5315.468453154692, 5352.759125839308, 5365.007473617374, 5376.220448035033, 5117.1556693145585, 5164.6384753067305, 5167.147420675622, 5173.844784656429, 5174.249733788617, 19722.802771972383, 19880.105395257247, 20002.59994800096, 20494.0, 20665.690014649794, 1982.553925366781, 2029.995152399557, 2051.9589608207903, 2060.8969551522364, 2287.096596844254, 8799.34004949625, 8959.283257339397, 9055.456672599665, 9182.540872956326, 9326.90673093274, 1700.8071374222347, 1753.973690394645, 1762.6034142318003, 1765.7263124215767, 1773.3881810775263, 50883.49116508824, 51672.48327516714, 53149.73425132888, 53436.73281633567, 54111.18833217505, 9800.754981125529, 10173.84739228912, 10270.127039201752, 10270.229732769923, 10305.330153539995, 13157.671058223621, 13220.471181152838, 13245.602631920865, 13253.536126235536, 13298.268595227355, 7442.85114297711, 7627.389808815282, 7630.618469076524, 7635.350995165362, 7639.961800190964, 7346.265373462611, 7351.191368949411, 7363.7422690205585, 7388.408927285912, 7397.482176247719, 4224.324108142682, 4253.3194688849635, 4385.057212699221, 4419.42547468827, 4447.488538818077, 1806.2865168258727, 1869.5139263791511, 1871.5321169707572, 1874.9062546872601, 1879.2201236486978, 810.4772421788032, 897.708244820436, 946.8816397950256, 997.3018886779283, 1047.6228557719214, 16098.63161631251, 16141.919290403473, 16213.675726485404, 16576.585585360463, 16649.91675041617, 883.6686242659002, 943.5470973932551, 1005.6329439754437, 1027.8047171037629, 1044.237706474263, 9289.814203716023, 9354.766130846647, 9473.526323683789, 9650.903490965, 9739.853902191473, 520276.0, 526672.0, 528098.0, 532987.0, 540965.0, 42550.0, 42936.57063429388, 74949.87575186377, 75268.99999999891, 78426.0, 1124.241137232365, 1136.6362763915467, 1143.6168883424145, 1153.169717803197, 1159.0437888741822, 15055.696541997373, 15115.244237787847, 15203.391864325304, 15264.465743698916, 15281.923590381977, 33736.0, 34268.65731342655, 34734.0, 34847.303053939286, 35149.8242508796, 44857.0, 44956.325655115856, 46528.53471465242, 46735.53264467312, 47617.761911190224, 6806.659667016728, 6983.441324694114, 7203.783886483414, 7244.094488188976, 7397.593132377771, 10538.947305263731, 10543.89456105429, 10725.195610329101, 11188.272762270426, 11262.662120136409, 9580.18568421692, 9652.951735241279, 9838.75403114928, 9846.45844478532, 10154.796904062025, 10034.247431442525, 10367.27429079957, 10641.467926603793, 10641.574337026432, 10700.929907009237, 10123.797524049625, 10287.43419111956, 10401.0, 10585.629502967358, 10686.771021332646, 7354.816129596803, 7533.623318834146, 7574.659140338587, 7575.772726818204, 7609.543427394374, 8123.7156699515235, 8851.734447966572, 9421.905780942103, 10320.071193592612, 10375.066244038073], "unit": "score", "name": "jquery.html", "value": 8119.454153113894}, {"lowerIsBetter": false, "replicates": [1443.1341195282828, 1489.4414594527052, 1657.635320229549, 1793.4798908316588, 1825.9543511412205, 7474.364679002285, 7618.162002179763, 7677.8848317275215, 7784.571848548328, 7945.165757595456, 7963.3231175350165, 8008.639611217494, 8081.959590202056, 8096.392770542204, 8109.553974531398, 2348.7181538215395, 2370.715514138306, 2375.228050883461, 2376.786089251967, 2382.297222319411, 2404.038384646138, 2422.454947636785, 2434.4035711250767, 2434.4887573609476, 2435.914742983996, 2316.444053427174, 2363.1728894886824, 2381.8928148233285, 2392.6889504364494, 2399.9640005399933, 2353.5881220786296, 2354.9646755298686, 2371.9525609487887, 2393.9162129325478, 2400.759924007603, 2411.348935787345, 2420.721617014031, 2429.149797570854, 2438.5366780311683, 2440.755924407563, 7845.137034926153, 7848.921510784933, 7861.371090312761, 7865.488743231672, 7917.445778795487, 4974.955259395531, 5036.21938599514, 5052.671576347526, 5060.84817455477, 5112.156494178456, 3057.1745628680133, 3059.724624783758, 3114.797538160012, 3137.51368537877, 3143.0, 995.6813819577739, 1002.7042022603349, 1019.9643012494602, 1029.1663752360537, 1053.425882893817, 10978.670639880816, 11027.944860275647, 11082.335059896352, 11125.833112503318, 11136.109111271078, 4357.172137293967, 4367.497737760198, 4477.462704475483, 4480.0, 4494.52807455219, 8875.866861997076, 8876.51179185151, 8878.73363799087, 8887.333449991276, 8898.154675305836, 4812.302216178705, 4815.2054910939305, 4861.368022157168, 4882.462929077798, 4897.0450762101045, 4416.712913660602, 4437.267850804646, 4443.133588950188, 4474.082813023322, 4504.797284122223, 3497.667721566447, 3589.8743543976357, 3611.566612006576, 3630.745847790682, 3639.490471334015, 1063.4310643805527, 1090.5855774805682, 1111.9388433636227, 1113.0650253786857, 1148.8219326004482, 990.0792263195153, 1059.998301604976, 1145.7192987718063, 1148.724306166514, 1341.8121462995189, 7177.3899218567, 7188.892166617505, 7225.205227424979, 7230.746923857745, 7254.492185547067, 607.7872744539465, 616.0420546050844, 616.8396216983616, 617.1945610977717, 759.35509554141, 5253.212018197301, 5275.366955965309, 5317.601179911522, 5322.787088516493, 5366.91949620756, 9126.771830704285, 9275.675351362805, 9289.62841486333, 9352.859707104399, 9415.293852961055, 9225.261979041661, 9229.261659067259, 9261.583228754722, 9271.165595096474, 9303.813923721487, 7304.342609165201, 7481.476296659182, 7492.550446973199, 7514.0607424071995, 7540.547567145989, 7292.781216563511, 7388.963055184689, 7395.371393431618, 7425.554466732014, 7449.5902725350625, 8513.276371508491, 8524.914750852413, 8640.395172337876, 8684.78288042804, 8742.956285218534, 8507.787305317417, 8885.644574216958, 8887.466751994902, 8921.464712117293, 8985.101489850962, 6801.659917004031, 6861.55399899005, 6902.206246281742, 6902.585844849325, 6931.480138989495, 7232.855342893218, 7336.229695881855, 7378.372838308804, 7428.73999410018, 7455.701771929279, 7068.11648543932, 7219.530730502501, 7236.746713864989, 7314.670839812327, 7454.925450745423, 6842.55523390978, 6867.866801977618, 6944.097267355211, 6949.513534052568, 6971.407430368476, 7070.151581810215, 7084.858302834017, 7093.0, 7120.643967801693, 7135.0, 6342.207224096988, 6355.014972679242, 6364.363563643598, 6364.427201551883, 6374.553781235269, 6524.706388212447, 6600.570962887397, 6625.602463852184, 6633.469322454289, 6702.36327548882], "unit": "score", "name": "mootools.html", "value": 4485.3192951749525}, {"lowerIsBetter": false, "replicates": [348.44597090625905, 353.129535694513, 353.5739433982052, 354.4046002715437, 360.1787923534341, 6216.254049514053, 6231.563790534658, 6234.688265586719, 6263.718132684029, 6334.271558770749, 6051.87896242076, 6177.598456100351, 6188.350223226553, 6196.442320191182, 6220.688965551727, 4787.54518320759, 4789.0, 4811.0, 4816.6869153504995, 4820.060088282787, 4824.035192961404, 4825.469198388175, 4826.951730482685, 4827.131116399047, 4837.492063333352, 4711.316859055435, 4759.833405830796, 4763.4998325175875, 4780.593649539794, 4785.21044027735, 4719.480857105716, 4743.407074115736, 4750.477447480775, 4755.881102972453, 4764.523547645243, 4159.771212583307, 4165.75005499671, 4177.874663760092, 4187.727797693171, 4195.3916682081235, 5884.205632239678, 5902.203202567642, 5906.763729450817, 5912.260967379078, 5917.881642367129, 5436.103042997901, 5515.145152501369, 5535.557155427556, 5541.750621222055, 5549.334079910436, 6605.471562275006, 6618.7021584028835, 6636.435902948255, 6644.867102657968, 6655.500837437212, 4597.057603191338, 4603.447586289633, 4611.5619016193405, 4617.607503362218, 4631.8147274109, 6755.9324406755795, 6872.003559483846, 6918.5502942309095, 6928.757493487704, 6931.306869313079, 4678.087772884255, 4683.578477937002, 4685.0, 4693.389859318267, 4694.906101877943, 4728.71627702339, 4755.0, 4758.500357462417, 4760.7619619018915, 4762.976185119052, 5478.424765399655, 5500.944990550123, 5502.532284755761, 5516.14499752539, 5520.585956053312, 6556.377144171296, 6612.0, 6619.437347825488, 6661.600303981777, 6681.899771503431, 1612.927418266181, 1647.3328302037455, 1659.7095508286002, 1669.2571805546659, 1697.6859281033048, 1096.5339730614457, 1113.9387333696725, 1119.5465836336298, 1128.3850301585655, 1137.590467431724, 6136.478399336106, 6201.782937597162, 6204.844878878064, 6211.65835879031, 6217.036359364306, 6753.797386078426, 6767.35710107539, 6772.356626120511, 6775.424088952395, 6790.932090679129, 6044.335123136451, 6134.754609815646, 6162.0, 6171.105189747462, 6171.59884607499, 3630.981845090758, 3652.397354436488, 3674.430463278196, 3677.0807298175455, 3682.4108142697573, 6918.827029324207, 6922.134733158356, 6929.133858267716, 6935.618540980295, 6949.339812717783, 6845.623490707959, 6987.231404545598, 6991.860162796817, 6995.510314277952, 6995.755148569878, 6957.06079679247, 6959.851624482005, 6974.302569743087, 6974.686139123752, 6989.679902046487, 6762.4928130389435, 6770.96614516944, 6771.932280677327, 6778.457723382019, 6779.118714567075, 6624.9337506624315, 6654.434373078343, 6665.0335701324, 6692.364225398579, 6712.0, 6941.479389045943, 6952.826179345355, 6956.991236270611, 6963.8607227854145, 6972.09362782835, 4611.446626404853, 4651.395318608695, 4661.254199328091, 4664.86005419838, 4669.276262179367, 6731.764388246388, 6792.456603471809, 6797.4901882358035, 6802.523823332319, 6854.10896583441, 6652.002199670088, 6682.398584127452, 6705.698243579148, 6709.966450167718, 6718.966405167943, 6665.433438157811, 6693.732250709917, 6697.966510167418, 6702.530822842355, 6709.094272273181, 6482.805515834532, 6537.640429776408, 6550.672466376567, 6571.474282057519, 6581.506387021088, 6662.733490660319, 6711.597304161766, 6715.328467153246, 6723.394894459522, 6730.562513436611, 6548.508861835287, 6559.0, 6560.737570497317, 6568.6058836469965, 6580.638064906476], "unit": "score", "name": "prototype.html", "value": 4980.144259448174}, {"lowerIsBetter": false, "replicates": [660.8149718078937, 705.7917914215305, 721.5598484924197, 765.3226894198637, 826.9834603307934, 15348.462803801869, 15607.0, 15622.687546249068, 15654.84345156548, 15735.055896646209, 14345.354459049342, 14387.856121438783, 14429.855701442983, 14446.277686115678, 14476.0, 793.8809178623195, 808.3290868579065, 809.2595275323073, 827.9296259817922, 829.2039641943742, 818.0183779464636, 819.4755356571799, 821.2157389692829, 821.2895845093981, 822.8272062866805, 853.0999795216045, 853.2619284319051, 855.1363123245536, 855.5722138930535, 857.0229937870832, 853.2320911179926, 853.9444936079135, 854.6196942360652, 854.7222152800365, 854.8290341931607, 625.1060982794602, 629.6033498895666, 629.902365133405, 630.533405280094, 631.3654776949182, 13036.739265214643, 13228.933855330759, 13292.667683307898, 13312.86687133126, 13337.0, 11934.701632459171, 12323.383830808514, 12368.44342004612, 12711.555095571703, 12872.664274223487, 9790.755231119208, 9902.455364954925, 9949.801003979952, 10591.788164236672, 11051.557937682483, 3396.6603339666085, 3397.3375191837604, 3456.87900923469, 3515.929681406383, 3640.908977275563, 41330.0, 42381.576184238074, 42399.36400953988, 42473.36289955653, 42479.0, 8646.697365592174, 8895.377323587287, 8896.065913079034, 9063.456192628464, 9208.401453905608, 15555.377784888478, 15667.686646267239, 15719.214039297989, 15737.370505179893, 15766.92116539433, 6995.685194166274, 7032.226455089936, 7250.0574925260435, 7326.340629343278, 7619.228197630851, 4301.376300436419, 4311.461067366579, 4322.562640779748, 4344.587264209895, 4447.332900064951, 3093.876244950177, 3109.176068341891, 3115.2211947013247, 3121.048080335474, 3123.6251649801716, 571.2944513525792, 582.9970850145722, 583.8511179649163, 584.4535359438938, 584.558658213055, 551.1539786427815, 589.8584339758427, 674.3680293689283, 678.9916973294653, 702.3994484715597, 8836.425632333878, 8919.10808919103, 8928.955355223183, 8942.195202431813, 9093.81812363749, 515.9380874295109, 577.0882006429831, 593.6497466494789, 711.0969069281983, 716.759885438384, 4034.293998550301, 4246.766427846498, 4335.002949321673, 4415.955840441618, 4459.420275364247, 49757.0, 50182.74908625506, 54393.72803135959, 54964.0, 55043.17435238475, 43709.56290437055, 44517.77741111274, 44629.0, 45141.774291128335, 45156.77421612871, 43709.56290437055, 43764.34353484637, 44234.0, 44526.10947781026, 45177.32234016492, 8791.956040219759, 8878.911210887809, 8966.575157493431, 9180.17378435944, 9260.0, 30736.231594210323, 30981.225469363446, 31921.201969950936, 32187.0, 32313.838430807697, 38449.6155038446, 41451.1709765809, 41995.0, 42102.578974209864, 42212.577874220864, 10417.843732344172, 10570.735731606772, 10668.83996740065, 10801.459927003776, 11534.769304614028, 12080.53024355808, 12139.150259481752, 12215.877841221474, 12292.262464252173, 12453.750924981268, 10195.898041019494, 10430.634927777795, 10648.201384896009, 10648.520816563117, 10811.729706757395, 10877.292975956538, 10995.065419439437, 11120.944395277971, 11210.327380357205, 11403.714907127389, 11242.325460472397, 11259.887401126212, 11275.436228188722, 11766.058715302926, 11773.293602383885, 9015.098490150933, 9365.344425890122, 9723.9027609723, 9761.902380976384, 9983.500824958868, 8664.653413863627, 9225.72322830316, 10104.141148002502, 10135.0, 10157.796844063225], "unit": "score", "name": "yui.html", "value": 6188.668069169237}], "name": "dromaeo_css", "value": 6915.823865191532}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 114.0, 111.0, 111.0, 124.0, 111.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 153.0, 171.0, 128.0, 155.0, 151.0, 128.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 162.0, 162.0, 162.0, 163.0, 171.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 74.0, 73.0, 74.0, 73.0, 136.0, 71.0, 71.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 142.0, 97.0, 98.0, 97.0, 140.0, 96.0, 96.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 145.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 101.0, 95.0, 96.0, 98.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 63.0, 58.0, 60.0, 59.0, 60.0, 61.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 67.0, 67.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 96.0, 87.0, 95.0, 86.0, 87.0, 89.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.7}, {"lowerIsBetter": true, "replicates": [125.0, 122.0, 126.0, 121.0, 124.0, 132.0, 128.0, 122.0, 129.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [147.0, 153.0, 152.0, 152.0, 154.0, 142.0, 151.0, 150.0, 142.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 71.0, 68.0, 82.0, 69.0, 68.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1525.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [196.8503937007874], "unit": "score", "name": "DeltaBlue", "value": 335.87944}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [731.528895391368], "unit": "score", "name": "Earley", "value": 911.0549209999997}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [40900.0], "unit": "score", "name": "RegExp", "value": 22.27347188264058}, {"lowerIsBetter": false, "replicates": [581.7335660267597], "unit": "score", "name": "Splay", "value": 140.08302900000007}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20276.538822795825}]} 10:13:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20276.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1525.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6915.82"}}} 10:13:37 INFO - Return code: 0 10:13:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:13:37 INFO - # TBPL SUCCESS # 10:13:37 INFO - Running post-action listener: _resource_record_post_action 10:13:37 INFO - Running post-run listener: _resource_record_post_run 10:13:38 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 558878720; Read time: 0; Write time: 1187384 10:13:38 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 239550464; Read time: 0; Write time: 557000 10:13:38 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 319328256; Read time: 0; Write time: 630384 10:13:38 INFO - Running post-run listener: _upload_blobber_files 10:13:38 INFO - Blob upload gear active. 10:13:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:13:38 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 10:13:38 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:13:38 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:13:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:40 INFO - (blobuploader) - INFO - Done attempting. 10:13:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:13:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:41 INFO - (blobuploader) - INFO - Done attempting. 10:13:41 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:41 INFO - Return code: 0 10:13:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:13:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c668174e2fce9b790221fc96327f180ac4f37cff7f2c71a4998db71e975c70618440b368b6f4dedb85818ee9d3695f73dcb0fbf0d18eb7f2b62b7310cf4e3ce6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf8da1a5d31c367ce636b111c5c422b79541a80df3e79ad9025d8012874b1b4b298848904ced6b98b5dd3abe8ee2e13cb0102ba9b8a5d86fad0ec3cb32353928"} 10:13:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:13:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:13:41 INFO - Contents: 10:13:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c668174e2fce9b790221fc96327f180ac4f37cff7f2c71a4998db71e975c70618440b368b6f4dedb85818ee9d3695f73dcb0fbf0d18eb7f2b62b7310cf4e3ce6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf8da1a5d31c367ce636b111c5c422b79541a80df3e79ad9025d8012874b1b4b298848904ced6b98b5dd3abe8ee2e13cb0102ba9b8a5d86fad0ec3cb32353928"} 10:13:41 INFO - Copying logs to upload dir... 10:13:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.676368 ========= master_lag: -0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-11 10:13:41.088994) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 10:13:41.092094) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c668174e2fce9b790221fc96327f180ac4f37cff7f2c71a4998db71e975c70618440b368b6f4dedb85818ee9d3695f73dcb0fbf0d18eb7f2b62b7310cf4e3ce6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf8da1a5d31c367ce636b111c5c422b79541a80df3e79ad9025d8012874b1b4b298848904ced6b98b5dd3abe8ee2e13cb0102ba9b8a5d86fad0ec3cb32353928"} build_url:https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/KkXbtFiCR1mS00ybhJSgoQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c668174e2fce9b790221fc96327f180ac4f37cff7f2c71a4998db71e975c70618440b368b6f4dedb85818ee9d3695f73dcb0fbf0d18eb7f2b62b7310cf4e3ce6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf8da1a5d31c367ce636b111c5c422b79541a80df3e79ad9025d8012874b1b4b298848904ced6b98b5dd3abe8ee2e13cb0102ba9b8a5d86fad0ec3cb32353928"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 10:13:41.116664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:13:41.116985) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452534589.823920-1927934771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 10:13:41.199814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 10:13:41.200124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 10:13:41.200452) ========= ========= Total master_lag: 0.02 =========