builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1451655804.73 results: success (0) buildid: 20160101030330 builduid: 6a88e59bdf95450786b9c96509b3e903 revision: 22f51211915bf7daff076180847a7140d35aa353 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.729673) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.730121) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.730463) ========= 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=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006503 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.785571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.785893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.898223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.898534) ========= 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=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.953560) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.953964) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.954449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:24.954942) ========= 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=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 05:43:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-01-01 05:43:25 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151097 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.122881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.123233) ========= 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=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020502 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.180421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.180773) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22f51211915bf7daff076180847a7140d35aa353 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 22f51211915bf7daff076180847a7140d35aa353 --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=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 05:43:25,536 truncating revision to first 12 chars 2016-01-01 05:43:25,536 Setting DEBUG logging. 2016-01-01 05:43:25,536 attempt 1/10 2016-01-01 05:43:25,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22f51211915b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 05:43:25,846 unpacking tar archive at: mozilla-central-22f51211915b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623751 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.826826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.827201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.842650) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.842931) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 05:43:25.843432) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-01 05:43:25.843752) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:26 INFO - MultiFileLogger online at 20160101 05:43:26 in /builds/slave/test-pgo 05:43:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:43:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:43:26 INFO - {'append_to_log': False, 05:43:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:43:26 INFO - 'blob_upload_branch': 'Firefox', 05:43:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:43:26 INFO - 'branch': 'Firefox', 05:43:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:26 INFO - 'config_files': ('talos/linux_config.py',), 05:43:26 INFO - 'default_actions': ('clobber', 05:43:26 INFO - 'read-buildbot-config', 05:43:26 INFO - 'download-and-extract', 05:43:26 INFO - 'populate-webroot', 05:43:26 INFO - 'create-virtualenv', 05:43:26 INFO - 'install', 05:43:26 INFO - 'run-tests'), 05:43:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:26 INFO - 'download_minidump_stackwalk': True, 05:43:26 INFO - 'download_symbols': 'ondemand', 05:43:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:26 INFO - 'installer_path': 'installer.exe', 05:43:26 INFO - 'log_level': 'info', 05:43:26 INFO - 'log_name': 'talos', 05:43:26 INFO - 'log_to_console': True, 05:43:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:26 INFO - 'opt_config_files': (), 05:43:26 INFO - 'pip_index': False, 05:43:26 INFO - 'sps_profile': False, 05:43:26 INFO - 'sps_profile_interval': 0, 05:43:26 INFO - 'suite': 'dromaeojs-e10s', 05:43:26 INFO - 'system_bits': '32', 05:43:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:26 INFO - 'title': 'talos-linux64-ix-033', 05:43:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:26 INFO - 'use_talos_json': True, 05:43:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:43:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:26 INFO - 'work_dir': 'build'} 05:43:26 INFO - ##### 05:43:26 INFO - ##### Running clobber step. 05:43:26 INFO - ##### 05:43:26 INFO - Running pre-action listener: _resource_record_pre_action 05:43:26 INFO - Running main action method: clobber 05:43:26 INFO - rmtree: /builds/slave/test-pgo/build 05:43:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:43:27 INFO - Running post-action listener: _resource_record_post_action 05:43:27 INFO - ##### 05:43:27 INFO - ##### Running read-buildbot-config step. 05:43:27 INFO - ##### 05:43:27 INFO - Running pre-action listener: _resource_record_pre_action 05:43:27 INFO - Running main action method: read_buildbot_config 05:43:27 INFO - Using buildbot properties: 05:43:27 INFO - { 05:43:27 INFO - "project": "", 05:43:27 INFO - "product": "firefox", 05:43:27 INFO - "script_repo_revision": "production", 05:43:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:43:27 INFO - "repository": "", 05:43:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:43:27 INFO - "buildid": "20160101030330", 05:43:27 INFO - "stage_platform": "linux64-pgo", 05:43:27 INFO - "basedir": "/builds/slave/test-pgo", 05:43:27 INFO - "nightly_build": "True", 05:43:27 INFO - "buildnumber": 602, 05:43:27 INFO - "slavename": "talos-linux64-ix-033", 05:43:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:43:27 INFO - "platform": "ubuntu64_hw", 05:43:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:27 INFO - "branch": "mozilla-central", 05:43:27 INFO - "repo_path": "mozilla-central", 05:43:27 INFO - "revision": "22f51211915bf7daff076180847a7140d35aa353", 05:43:27 INFO - "pgo_build": "True", 05:43:27 INFO - "builduid": "6a88e59bdf95450786b9c96509b3e903", 05:43:27 INFO - "slavebuilddir": "test" 05:43:27 INFO - } 05:43:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:43:27 INFO - Running post-action listener: _resource_record_post_action 05:43:27 INFO - ##### 05:43:27 INFO - ##### Running download-and-extract step. 05:43:27 INFO - ##### 05:43:27 INFO - Running pre-action listener: _resource_record_pre_action 05:43:27 INFO - Running main action method: download_and_extract 05:43:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:27 INFO - https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/test_packages.json 05:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/test_packages.json 05:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:43:28 INFO - Downloaded 1302 bytes. 05:43:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:43:28 INFO - Using the following test package requirements: 05:43:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:28 INFO - u'jsshell-linux-x86_64.zip'], 05:43:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:28 INFO - https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:30 INFO - Downloaded 23195499 bytes. 05:43:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:43:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:43:31 INFO - Return code: 0 05:43:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:31 INFO - https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:33 INFO - Downloaded 23195499 bytes. 05:43:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:43:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:43:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:43:35 INFO - Return code: 0 05:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:35 INFO - https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:43:37 INFO - Downloaded 11132285 bytes. 05:43:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:43:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:43:38 INFO - Return code: 0 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:38 INFO - https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:43:40 INFO - Downloaded 54949595 bytes. 05:43:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:40 INFO - mkdir: /builds/slave/test-pgo/properties 05:43:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:43:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:43:40 INFO - Contents: 05:43:40 INFO - build_url:https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:43:40 INFO - Running post-action listener: _resource_record_post_action 05:43:40 INFO - Running post-action listener: set_extra_try_arguments 05:43:40 INFO - ##### 05:43:40 INFO - ##### Running populate-webroot step. 05:43:40 INFO - ##### 05:43:40 INFO - Running pre-action listener: _resource_record_pre_action 05:43:40 INFO - Running main action method: populate_webroot 05:43:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:40 INFO - '--tppagecycles', 05:43:40 INFO - '7'], 05:43:40 INFO - 'tests': ['tsvgm']}}, 05:43:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:43:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['damp', 'tps']}, 05:43:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['damp', 'tps']}, 05:43:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:43:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:40 INFO - 'other': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other_l64': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:43:40 INFO - 'ts_paint', 05:43:40 INFO - 'tpaint', 05:43:40 INFO - 'sessionrestore', 05:43:40 INFO - 'sessionrestore_no_auto_restore']}, 05:43:40 INFO - 'svgr': {'tests': ['tsvgx', 05:43:40 INFO - 'tsvgr_opacity', 05:43:40 INFO - 'tart', 05:43:40 INFO - 'tscrollx', 05:43:40 INFO - 'cart']}, 05:43:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tsvgx', 05:43:40 INFO - 'tsvgr_opacity', 05:43:40 INFO - 'tart', 05:43:40 INFO - 'tscrollx', 05:43:40 INFO - 'cart']}, 05:43:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'tests': ['tp5o']}, 05:43:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s'], 05:43:40 INFO - 'tests': ['tp5o']}, 05:43:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--xperf_path', 05:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:40 INFO - 'tests': ['tp5n']}, 05:43:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:40 INFO - 'talos_options': ['--e10s', 05:43:40 INFO - '--xperf_path', 05:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:40 INFO - 'tests': ['tp5n']}}, 05:43:40 INFO - 'talos.zip': {'path': '', 05:43:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:40 INFO - Running post-action listener: _resource_record_post_action 05:43:40 INFO - ##### 05:43:40 INFO - ##### Running create-virtualenv step. 05:43:40 INFO - ##### 05:43:40 INFO - Running pre-action listener: _resource_record_pre_action 05:43:40 INFO - Running main action method: create_virtualenv 05:43:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:43:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:43:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:43:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:40 INFO - Using real prefix '/usr' 05:43:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:43:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:43 INFO - Installing pip.................done. 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:43:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:43 INFO - Cleaning up... 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:43:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:43 INFO - Downloading/unpacking psutil>=0.7.1 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:43:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:43:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:45 INFO - Installing collected packages: psutil 05:43:45 INFO - Running setup.py install for psutil 05:43:45 INFO - building 'psutil._psutil_linux' extension 05:43:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:43:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:43:45 INFO - building 'psutil._psutil_posix' extension 05:43:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:43:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:45 INFO - Successfully installed psutil 05:43:45 INFO - Cleaning up... 05:43:45 INFO - Return code: 0 05:43:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:45 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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:43:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:43:45 INFO - Using env: {'DISPLAY': ':0', 05:43:45 INFO - 'HOME': '/home/cltbld', 05:43:45 INFO - 'LANG': 'en_US.UTF-8', 05:43:45 INFO - 'LANGUAGE': 'en_US:en', 05:43:45 INFO - 'LOGNAME': 'cltbld', 05:43:45 INFO - 'MAIL': '/var/mail/cltbld', 05:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:45 INFO - 'MOZ_NO_REMOTE': '1', 05:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:45 INFO - 'NO_EM_RESTART': '1', 05:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:45 INFO - 'SHELL': '/bin/bash', 05:43:45 INFO - 'SHLVL': '1', 05:43:45 INFO - 'TERM': 'linux', 05:43:45 INFO - 'TMOUT': '86400', 05:43:45 INFO - 'USER': 'cltbld', 05:43:45 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:45 INFO - '_': '/tools/buildbot/bin/python'} 05:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:43:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:43:47 INFO - Installing collected packages: mozsystemmonitor 05:43:47 INFO - Running setup.py install for mozsystemmonitor 05:43:47 INFO - Successfully installed mozsystemmonitor 05:43:47 INFO - Cleaning up... 05:43:47 INFO - Return code: 0 05:43:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:43: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')]} 05:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', '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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:43: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 blobuploader==1.2.4 05:43:47 INFO - Using env: {'DISPLAY': ':0', 05:43:47 INFO - 'HOME': '/home/cltbld', 05:43:47 INFO - 'LANG': 'en_US.UTF-8', 05:43:47 INFO - 'LANGUAGE': 'en_US:en', 05:43:47 INFO - 'LOGNAME': 'cltbld', 05:43:47 INFO - 'MAIL': '/var/mail/cltbld', 05:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:47 INFO - 'MOZ_NO_REMOTE': '1', 05:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:47 INFO - 'NO_EM_RESTART': '1', 05:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:47 INFO - 'SHELL': '/bin/bash', 05:43:47 INFO - 'SHLVL': '1', 05:43:47 INFO - 'TERM': 'linux', 05:43:47 INFO - 'TMOUT': '86400', 05:43:47 INFO - 'USER': 'cltbld', 05:43:47 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:47 INFO - '_': '/tools/buildbot/bin/python'} 05:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:43:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:43:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - Downloading docopt-0.6.1.tar.gz 05:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:50 INFO - Running setup.py install for blobuploader 05:43:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:43:50 INFO - Running setup.py install for requests 05:43:51 INFO - Running setup.py install for docopt 05:43:51 INFO - Successfully installed blobuploader requests docopt 05:43:51 INFO - Cleaning up... 05:43:51 INFO - Return code: 0 05:43:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:43:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:51 INFO - Using env: {'DISPLAY': ':0', 05:43:51 INFO - 'HOME': '/home/cltbld', 05:43:51 INFO - 'LANG': 'en_US.UTF-8', 05:43:51 INFO - 'LANGUAGE': 'en_US:en', 05:43:51 INFO - 'LOGNAME': 'cltbld', 05:43:51 INFO - 'MAIL': '/var/mail/cltbld', 05:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:51 INFO - 'MOZ_NO_REMOTE': '1', 05:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:51 INFO - 'NO_EM_RESTART': '1', 05:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:51 INFO - 'SHELL': '/bin/bash', 05:43:51 INFO - 'SHLVL': '1', 05:43:51 INFO - 'TERM': 'linux', 05:43:51 INFO - 'TMOUT': '86400', 05:43:51 INFO - 'USER': 'cltbld', 05:43:51 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:51 INFO - '_': '/tools/buildbot/bin/python'} 05:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:51 INFO - Running setup.py (path:/tmp/pip-VZXyBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:51 INFO - Running setup.py (path:/tmp/pip-BOjLyX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:51 INFO - Running setup.py (path:/tmp/pip-jaMKl5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:51 INFO - Running setup.py (path:/tmp/pip-YDxXZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:51 INFO - Running setup.py (path:/tmp/pip-9uEv0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:51 INFO - Running setup.py (path:/tmp/pip-joQ0Qs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:51 INFO - Running setup.py (path:/tmp/pip-QADCKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:51 INFO - Running setup.py (path:/tmp/pip-DfpuXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:51 INFO - Running setup.py (path:/tmp/pip-aUQbX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:52 INFO - Running setup.py (path:/tmp/pip-dlp7jv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:52 INFO - Running setup.py (path:/tmp/pip-ATZc9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:52 INFO - Running setup.py (path:/tmp/pip-OjMCNa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:52 INFO - Running setup.py (path:/tmp/pip-m23eDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:52 INFO - Running setup.py (path:/tmp/pip-5z3B3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:52 INFO - Running setup.py (path:/tmp/pip-FM7H9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:52 INFO - Running setup.py (path:/tmp/pip-aJ0AEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:52 INFO - Running setup.py (path:/tmp/pip-HVMin9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:52 INFO - Running setup.py install for manifestparser 05:43:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:43:52 INFO - Running setup.py install for mozcrash 05:43:52 INFO - Running setup.py install for mozdebug 05:43:52 INFO - Running setup.py install for mozdevice 05:43:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozfile 05:43:53 INFO - Running setup.py install for mozhttpd 05:43:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozinfo 05:43:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozInstall 05:43:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozleak 05:43:53 INFO - Running setup.py install for mozlog 05:43:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for moznetwork 05:43:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozprocess 05:43:53 INFO - Running setup.py install for mozprofile 05:43:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozrunner 05:43:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for mozscreenshot 05:43:54 INFO - Running setup.py install for moztest 05:43:54 INFO - Running setup.py install for mozversion 05:43:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:43:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:54 INFO - Running setup.py (path:/tmp/pip-35jmE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:54 INFO - Running setup.py (path:/tmp/pip-TvoyYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:54 INFO - Running setup.py (path:/tmp/pip-qSe0hu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:54 INFO - Running setup.py (path:/tmp/pip-8vHqkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:54 INFO - Running setup.py (path:/tmp/pip-zCkPQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:55 INFO - Running setup.py (path:/tmp/pip-TFnRL1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:55 INFO - Running setup.py (path:/tmp/pip-eFGKZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:55 INFO - Running setup.py (path:/tmp/pip-pDqtoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:55 INFO - Running setup.py (path:/tmp/pip-XJYXBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:55 INFO - Running setup.py (path:/tmp/pip-Yz4Aqd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:55 INFO - Running setup.py (path:/tmp/pip-no1iQk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:55 INFO - Running setup.py (path:/tmp/pip-Xrvtgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:55 INFO - Running setup.py (path:/tmp/pip-NG7FZV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:55 INFO - Running setup.py (path:/tmp/pip-hGzYvA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:55 INFO - Running setup.py (path:/tmp/pip-gZumef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:55 INFO - Running setup.py (path:/tmp/pip-birC7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:55 INFO - Running setup.py (path:/tmp/pip-tu_LRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:57 INFO - Downloading blessings-1.5.1.tar.gz 05:43:57 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:57 INFO - Installing collected packages: blessings 05:43:57 INFO - Running setup.py install for blessings 05:43:57 INFO - Successfully installed blessings 05:43:57 INFO - Cleaning up... 05:43:57 INFO - Return code: 0 05:43:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:43:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:58 INFO - Reading from file tmpfile_stdout 05:43:58 INFO - Current package versions: 05:43:58 INFO - argparse == 1.2.1 05:43:58 INFO - blessings == 1.5.1 05:43:58 INFO - blobuploader == 1.2.4 05:43:58 INFO - docopt == 0.6.1 05:43:58 INFO - manifestparser == 1.1 05:43:58 INFO - mozInstall == 1.12 05:43:58 INFO - mozcrash == 0.16 05:43:58 INFO - mozdebug == 0.1 05:43:58 INFO - mozdevice == 0.47 05:43:58 INFO - mozfile == 1.2 05:43:58 INFO - mozhttpd == 0.7 05:43:58 INFO - mozinfo == 0.9 05:43:58 INFO - mozleak == 0.1 05:43:58 INFO - mozlog == 3.1 05:43:58 INFO - moznetwork == 0.27 05:43:58 INFO - mozprocess == 0.22 05:43:58 INFO - mozprofile == 0.28 05:43:58 INFO - mozrunner == 6.11 05:43:58 INFO - mozscreenshot == 0.1 05:43:58 INFO - mozsystemmonitor == 0.0 05:43:58 INFO - moztest == 0.7 05:43:58 INFO - mozversion == 1.4 05:43:58 INFO - psutil == 3.1.1 05:43:58 INFO - requests == 1.2.3 05:43:58 INFO - wsgiref == 0.1.2 05:43:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 INFO - Downloading/unpacking jsonschema 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:44:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:44:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:00 INFO - warning: no files found matching '*.txt' 05:44:00 INFO - no previously-included directories found matching 'build' 05:44:00 INFO - no previously-included directories found matching 'dist' 05:44:00 INFO - no previously-included directories found matching '.git*' 05:44:00 INFO - Installing collected packages: jsonschema, functools32 05:44:00 INFO - Running setup.py install for functools32 05:44:00 INFO - warning: no files found matching '*.txt' 05:44:00 INFO - no previously-included directories found matching 'build' 05:44:00 INFO - no previously-included directories found matching 'dist' 05:44:00 INFO - no previously-included directories found matching '.git*' 05:44:00 INFO - Successfully installed jsonschema functools32 05:44:00 INFO - Cleaning up... 05:44:00 INFO - Return code: 0 05:44:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:00 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 0x7f00db52df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17566c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, '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': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:44:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:44:00 INFO - Using env: {'DISPLAY': ':0', 05:44:00 INFO - 'HOME': '/home/cltbld', 05:44:00 INFO - 'LANG': 'en_US.UTF-8', 05:44:00 INFO - 'LANGUAGE': 'en_US:en', 05:44:00 INFO - 'LOGNAME': 'cltbld', 05:44:00 INFO - 'MAIL': '/var/mail/cltbld', 05:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:00 INFO - 'MOZ_NO_REMOTE': '1', 05:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:00 INFO - 'NO_EM_RESTART': '1', 05:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:00 INFO - 'SHELL': '/bin/bash', 05:44:00 INFO - 'SHLVL': '1', 05:44:00 INFO - 'TERM': 'linux', 05:44:00 INFO - 'TMOUT': '86400', 05:44:00 INFO - 'USER': 'cltbld', 05:44:00 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:00 INFO - '_': '/tools/buildbot/bin/python'} 05:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:00 INFO - Downloading/unpacking flake8 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:44:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:44:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:44:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:44:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:03 INFO - no previously-included directories found matching 'docs/_build' 05:44:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:03 INFO - Running setup.py install for pep8 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:03 INFO - no previously-included directories found matching 'docs/_build' 05:44:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:44:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:03 INFO - Cleaning up... 05:44:03 INFO - Return code: 0 05:44:03 INFO - Running post-action listener: _resource_record_post_action 05:44:03 INFO - Running post-action listener: _start_resource_monitoring 05:44:03 INFO - Starting resource monitoring. 05:44:03 INFO - ##### 05:44:03 INFO - ##### Running install step. 05:44:03 INFO - ##### 05:44:03 INFO - Running pre-action listener: _resource_record_pre_action 05:44:03 INFO - Running main action method: install 05:44:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:44:03 INFO - Reading from file tmpfile_stdout 05:44:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:44:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:44:04 INFO - Reading from file tmpfile_stdout 05:44:04 INFO - Output received: 05:44:04 INFO - Usage: mozinstall [options] installer 05:44:04 INFO - Options: 05:44:04 INFO - -h, --help show this help message and exit 05:44:04 INFO - -d DEST, --destination=DEST 05:44:04 INFO - Directory to install application into. [default: 05:44:04 INFO - "/builds/slave/test-pgo"] 05:44:04 INFO - --app=APP Application being installed. [default: firefox] 05:44:04 INFO - mkdir: /builds/slave/test-pgo/build/application 05:44:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:44:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:44:19 INFO - Reading from file tmpfile_stdout 05:44:19 INFO - Output received: 05:44:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:44:19 INFO - Running post-action listener: _resource_record_post_action 05:44:19 INFO - ##### 05:44:19 INFO - ##### Running run-tests step. 05:44:19 INFO - ##### 05:44:19 INFO - Running pre-action listener: _resource_record_pre_action 05:44:19 INFO - Running main action method: run_tests 05:44:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:44:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:44:19 INFO - Python 2.7.3 05:44:19 INFO - Return code: 0 05:44:19 INFO - grabbing minidump binary from tooltool 05:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:19 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 0x1753e40>, '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 0x1754740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754bf0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:44:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:44:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:44:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:19 INFO - Return code: 0 05:44:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:44:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:44:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:44:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:44:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:44:20 INFO - Return code: 0 05:44:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/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 05:44:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/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 05:44:20 INFO - Using env: {'DISPLAY': ':0', 05:44:20 INFO - 'HOME': '/home/cltbld', 05:44:20 INFO - 'LANG': 'en_US.UTF-8', 05:44:20 INFO - 'LANGUAGE': 'en_US:en', 05:44:20 INFO - 'LOGNAME': 'cltbld', 05:44:20 INFO - 'MAIL': '/var/mail/cltbld', 05:44:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:20 INFO - 'MOZ_NO_REMOTE': '1', 05:44:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:20 INFO - 'NO_EM_RESTART': '1', 05:44:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:44:20 INFO - 'SHELL': '/bin/bash', 05:44:20 INFO - 'SHLVL': '1', 05:44:20 INFO - 'TERM': 'linux', 05:44:20 INFO - 'TMOUT': '86400', 05:44:20 INFO - 'USER': 'cltbld', 05:44:20 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887', 05:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:20 INFO - '_': '/tools/buildbot/bin/python'} 05:44:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/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 05:44:21 INFO - mozversion application_buildid: 20160101030330 05:44:21 INFO - mozversion application_changeset: 22f51211915bf7daff076180847a7140d35aa353 05:44:21 INFO - mozversion application_display_name: Nightly 05:44:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:21 INFO - mozversion application_name: Firefox 05:44:21 INFO - mozversion application_remotingname: firefox 05:44:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:21 INFO - mozversion application_vendor: Mozilla 05:44:21 INFO - mozversion application_version: 46.0a1 05:44:21 INFO - mozversion platform_buildid: 20160101030330 05:44:21 INFO - mozversion platform_changeset: 22f51211915bf7daff076180847a7140d35aa353 05:44:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:21 INFO - mozversion platform_version: 46.0a1 05:44:21 INFO - using testdate: 1451655861 05:44:21 INFO - actual date: 1451655861 05:44:21 INFO - starting webserver on 'localhost:39480' 05:44:21 INFO - SUITE-START | Running 3 tests 05:44:21 INFO - TEST-START | dromaeo_css 05:44:21 INFO - operating with platform_type : linux_ 05:44:21 INFO - Initialising browser for dromaeo_css test... 05:44:21 INFO - TEST-INFO | started process 17187 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl8eF6i/profile http://localhost:39480/getInfo.html) 05:44:26 INFO - PROCESS | 17187 | __metrics Screen width/height:1600/1200 05:44:26 INFO - PROCESS | 17187 | colorDepth:24 05:44:26 INFO - PROCESS | 17187 | Browser inner width/height: 1024/670 05:44:26 INFO - PROCESS | 17187 | __metrics 05:44:26 INFO - PROCESS | 17187 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:44:27 INFO - TEST-INFO | 17187: exit 0 05:44:27 INFO - Browser initialized. 05:44:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:27 INFO - TEST-INFO | started process 17316 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl8eF6i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:39 INFO - PROCESS | 17316 | RSS: Main: 150376448 05:44:39 INFO - PROCESS | 17316 | 05:45:28 INFO - PROCESS | 17316 | 1451655928964 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:47:37 INFO - PROCESS | 17316 | Cycle 1(1): loaded http://localhost:39480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39480/tests/dromaeo/cssquery-ext.html) 05:47:38 INFO - PROCESS | 17316 | RSS: Main: 156893184 05:47:38 INFO - PROCESS | 17316 | 05:50:41 INFO - PROCESS | 17316 | Cycle 1(1): loaded http://localhost:39480/tests/dromaeo/cssquery-ext.html (next: http://localhost:39480/tests/dromaeo/cssquery-jquery.html) 05:50:41 INFO - PROCESS | 17316 | RSS: Main: 153047040 05:50:41 INFO - PROCESS | 17316 | 05:53:43 INFO - PROCESS | 17316 | Cycle 1(1): loaded http://localhost:39480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39480/tests/dromaeo/cssquery-mootools.html) 05:53:43 INFO - PROCESS | 17316 | RSS: Main: 153784320 05:53:43 INFO - PROCESS | 17316 | 05:56:45 INFO - PROCESS | 17316 | Cycle 1(1): loaded http://localhost:39480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39480/tests/dromaeo/cssquery-prototype.html) 05:56:46 INFO - PROCESS | 17316 | RSS: Main: 152121344 05:56:46 INFO - PROCESS | 17316 | 05:59:48 INFO - PROCESS | 17316 | Cycle 1(1): loaded http://localhost:39480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39480/tests/dromaeo/cssquery-yui.html) 05:59:49 INFO - PROCESS | 17316 | RSS: Main: 153399296 05:59:49 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | Cycle 1(1): loaded http://localhost:39480/tests/dromaeo/cssquery-yui.html (next: http://localhost:39480/tests/dromaeo/cssquery-dojo.html) 06:02:51 INFO - PROCESS | 17316 | RSS: Main: 155287552 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | __start_tp_report 06:02:51 INFO - PROCESS | 17316 | _x_x_mozilla_page_load 06:02:51 INFO - PROCESS | 17316 | _x_x_mozilla_page_load_details 06:02:51 INFO - PROCESS | 17316 | |i|pagename|runs| 06:02:51 INFO - PROCESS | 17316 | |0;dojo.html;3096.3497665490245;3163.272447337114;3196.2169268529215;3211.036688993302;3215.228345197152;5292.655977361469;5296.867578310545;5323;5327.866803329919;5350.946490535103;5245.659032162906;5334.226537152111;5354.089804733195;5359.732013399324;5365.141577347626;4589.105124500724;4843.854684359475;5003.724795136266;5004.824831130911;5037.49625037497;4801.711897286156;4893.070316639845;4942.308076869242;4954.87612809679;5009;4794.280857871329;4849.321095046696;4880.633952453581;4900.803967841282;4950.579200767921;4833.637477189225;4866.6106711463;4876.146674332013;4907;4917.557419832232;4774.73738944358;4848.878778030542;4858.611311095104;4881.0725962067445;4883.511648835123;5132.820351287687;5216.895662086737;5237.083510385667;5249.737513124329;5260.447652996419;5742.6841523716175;5751.942480575182;5760.683162426065;5774.82675519735;5776.797812076599;5801.187833703285;5809.564282678816;5818.912716309259;5820.505257053113;5825.708714564297;5333.439988801198;5361.839144825662;5416.864578385533;5455.0453670607885;5471.917921231185;5815.621984570989;5856.795012174639;5858.765649374062;5859.912101318484;5892.705364731832;5633.352164501053;5645.491905728504;5675.347335056521;5697.800576979786;5708;5642.943570564242;5688.06146985751;5713.114467257582;5721.141828725641;5747.166660834156;5648.350439699405;5713.885722285614;5751;5767.711614419346;5772.855678608068;5640.887182256414;5649.745761440745;5686.488216060575;5691.089425691869;5698.772049118072;4374.518802931675;4391.538888416734;4397.472303323558;4399.1641588098155;4409.955900440955;3862.9034274143373;3899.6100389960775;3917.1578110706337;3954.189391174802;3962.742421742635;5326.334208223972;5386.569074474032;5389.703566303812;5396.325459317585;5405.864853378697;5844.298684157929;5870.6771127587535;5873.618214816109;5873.676947767828;5875.794347197913;5285.180796976475;5285.524302812765;5328.706921119298;5351.5718742501285;5431.972840135774;4869.537393947569;4892.926606100911;4899.387576552931;4920.3111564381015;4952.20764677657;5812.680302583399;5813.215215945877;5818.6217895836635;5819.592628516048;5827.067669172912;5690.231818704422;5822.679752613647;5830.5627077968475;5883.94116058834;5924.11138329254;5824.242848429677;5831.79588714393;5832.591718579828;5862;5867.178594996619;5590.273264475755;5666.17840413146;5682.090865461506;5682.318121825408;5697.971510142423;5793.073108302651;5815.5929084963645;5825.271841019872;5828.912566311594;5882.5293976480925;5561.805336813192;5584.106542953108;5597.776088956559;5600.663960162403;5624.775008999594;5493.725313734218;5582.051051321204;5585.106382978866;5588.972055139861;5699.088145896802;5473.863153421196;5493.121100623881;5556.472135147154;5565.220869078251;5621.494065534122;5553.08374118266;5619.831405057855;5663.32040155184;5676;5677.034904066236;5419.430959749169;5539.529140023144;5546.140348246028;5548.528375088163;5551.1673249011355 06:02:51 INFO - PROCESS | 17316 | |1;ext.html;514.8095204774235;515.0651567405159;530.5887936848942;543.8205392220563;554.2019491931618;34006.829965850164;34331.48502772454;34380.484292735564;34645.30709385814;34657;35979;36931.81534092333;36958.26083478335;37008.444873326924;37085.81457092718;8306.127856575078;8444.240018398343;8503.447275927076;8523.275521580643;8557.743267701948;8234.505929644241;8240.21717936795;8378.371622128334;8505.31957443403;8525.531095789729;8488.78778030548;8547.487150770943;8592.957035214815;8612.052674205863;8624.827503449927;8411.95794021029;8558.914410855874;8566.143385661446;8573.271271941892;8586.484810911365;8354.289885359753;8456.8731469028;8493.447925884859;8508.319334453228;8520.488770673717;37977.81011094955;38059.429108563396;38368.232635347136;38488.422673659916;38514.229715405534;2599.415131595395;3019.5168772996435;3169.065125787898;3433.9313213735586;3675.5773086095173;24911.87544062286;25115.246542603752;25202.747972520225;25431.491370172676;25730;3752.4934133891848;3956.7625942443256;3975.5428125765616;4042.353223484258;4158.438610787535;219336;220109;221138;222731;223924;48182.75908620434;49347.25979110316;54748.45251547513;55514.72242638761;55803;49512.79141273032;49855.50144498581;50171.24743128856;50222.748886256064;50307.49692503028;13404.128731632607;13437.529686461123;13472.461101555828;13545.322733863268;13803.792943105862;10140.442275674908;10229.386236825814;10338.844917326247;10469.9476502617;10500.73748156287;17990.550236243937;18283.90858045728;18397.816021839877;18411.447656570323;18445;7235.565866048054;7546.9622651887485;7550.282723141293;7583.544987300779;7589.620518974029;873.567115583098;927.7170463008712;965.6089283839916;968.6222373274429;1012.7468132966758;26453;26719.46561068768;26735.251727051647;27007.459850802872;27059.594106088425;951.9190868776093;954.9447860114612;974.8245315843217;978.6036655154674;1007.6019972110975;13832.308384580932;14013.579592612237;14016.929915350358;14113.5060272892;14203;318009;326939;328327;328587;329325;47258.29112563314;47622.5237747625;47696;47753.28370074452;47842.28236576454;1231.5997300877073;1241.0567968344124;1245.725940293134;1253.4547471849592;1256.2901960392348;25490;26519.33701657474;26750.331241719112;26795.464090717687;27014.72985270122;41631;42207;42322.576774231864;42416.57583424126;42439;298740;299631;299877;301360;302086.8956552208;26291.60562591601;26654.333641659112;29485.557716633837;29857;29863.552046718884;34718.65281347255;35339.29321413609;35605.28789424249;35821.134309254674;36070.27859442744;30431.69568304377;30735;30749;30878.84560577183;31870.52194217135;32653.346933061683;32769.180770480925;32805.83597081999;35647.82176089103;36998;32573.674263258014;32714.509282360308;35667.82166089153;35988.64011359853;36090.8195459021;27343.72656273412;29067.900557444493;30700.65841662757;31227.063188104392;31315.53026704647;24261;24463.633045503975;24663.7734284873;24762.25713228606;25015.624765628894 06:02:51 INFO - PROCESS | 17316 | |2;jquery.html;322.10615541871306;324.80998615809744;332.1612927358421;336.238419978748;339.13858798651427;15542;16083;16888.915555422238;17019.404320848742;17741.201645925932;13834;13902;13908.374123164456;13985.720285594307;14041.017128800988;4826.855194344175;5033.899322013557;5160.587153027749;5174.379074511064;5181.792728290864;4214.599613036757;4987.1521841286885;5042.067217564744;5051.696898186102;5581.944180558183;5514.476124768141;5527.695976721278;5534.501894829465;5560.916586251209;5561.555075593943;5538.196961440589;5715.457031581993;5744.597878148531;5745.856353591152;5747.2241247431475;5126.051680439131;5141.434442211354;5144.408393034774;5148.536631703128;5156.303898973628;12807.807882881763;12834.743305133938;19143;19765.505862353413;20238.291659791983;2055.732754741874;2074.761402438724;2084.6143463459307;2101.8528702990798;2124.6281900667323;9229.584668689926;9270.21203197729;9356.672516461891;9553.522323883779;9563.856542151872;1828.2321425001398;1862.9347972820885;1937.1670181821812;1970.881747095179;1995.950101247466;52541.73729131368;55300;56520;58444;63548.04677929881;10136.594536218468;10227.386356818615;10271.229657775697;10293.176545876311;10340.172786177087;12270.754584908253;12593;12610.432530536147;12619.558315458915;13007.869921300666;6689.6989635466525;6851.760188393382;7080.539764915264;7185.353318201387;7234;6723.63020033893;6728.529002969843;6832.658367081626;6926.06498122747;7014.964925175342;4290.184864875664;4379.868603941887;4393.736375817397;4404.515503294635;4421.7789110544345;1790.2838864454322;1793.6771381151518;1803.8376546110912;1811.275489804089;1844.1977739683011;388.5880966175806;392.9390944403622;411.28847094526037;830.3772170871846;865.3077537969599;9848.803023939481;10445.11216546587;10457.372557646566;10594;10810.891891081146;408.51998901290864;414.93153629651374;417.70551761008414;424.9171411574775;438.23746680775224;5551.9722401387735;5933.169356290123;5974.462298393166;9356.4386136832;9668.70993870185;525518;529513;536210.9136725904;541138;542077;78115.60942195366;78533.42933141305;80817.59591202006;81390;81643.5917820419;1075.1398880895254;1075.8977897099762;1078.1698092468755;1078.412265315405;1082.4154956323655;15335.923320383326;15399.461018864286;15524.689506209586;15552.688946221238;15868.285927133538;26462.338441538344;33659.15852103619;34376.82811585926;34634;35869.282614347045;39309.80345098256;40081.1983760329;40626.79686601548;40836.59163408447;41770.791146044074;9300.581473833558;9390.624375024923;9432.339736218673;9609.375390599589;9621.51892405363;12996.675083122998;17717.46847594574;17846.91076544609;18032.459026229233;18226;14641;14742;14759.778603321174;15077.773833392288;15230.162341071347;13792.724145517233;13992.930035349758;14332.283385830875;14408.711825763216;14786.63033424173;14592.343344549734;14627.92686036563;14900.7764883529;15064;15223.238838058274;9089.454632722058;9111.17999380059;9378.343515953818;9530.237580993642;9538.141567258703;13779.173249605055;14225.644358890697;14558.708825823212;14845.777313340093;14898.106113633217 06:02:51 INFO - PROCESS | 17316 | |3;mootools.html;1368.1927662679018;1369.3564024908292;1433.7060902514986;1601.4715144002466;1610.5973506623345;7359.116905971277;7406.222346653598;7419.962900185505;7475.99074124993;7575.356094731947;7516.774496765106;7521.548707077579;7547.169811320764;7628.5041472304265;7637.274458926393;2136.0387825478556;2182.563487302546;2190.8466407351493;2196.8352373572047;2197.670349447588;2157.094020511389;2186.6173419651495;2212.734471863371;2214.1586197245024;2216.6896634471186;2164.880931548772;2165.415337858777;2185.65029595264;2212.4358288636454;2218.0684112672716;2180.9781902180935;2201.6917631531596;2215.1582398688556;2218.5230175512343;2231.263682984611;2204.5921504521716;2242.3048854854883;2242.887855607213;2246.7416247131628;2247.224707475918;7371.299726525972;7388;7457.030586023782;7474.663640136207;7492.175860655324;4247.362895565659;4292.806823692941;4318.978405107954;4326.5673432656795;4335.739855608642;2886.0476042906002;2942.029130386967;2950.6606740224934;2982.7017298270216;2986.835724035177;922.944623322596;946.2382781860599;949.943003419797;960.0543464687278;1003.3377970539482;10178.745531361701;10232.488375581266;10250.436226007567;10250.897491025069;10259.384436933808;3889.2415978883846;3914.8629797956933;3947.2302900934615;3949.0917089069676;3969.960300397017;8215.137410571924;8258.958705206556;8275.875861861956;8311.210435008665;8385.077641459435;4209.326507758744;4294.377315289265;4299.570042995738;4300.483941926988;4327.37253098299;3898.8440462381755;3930.3514920037874;3936.822842972073;3939.153082087365;3963.207358528306;3181.9681803182134;3185.155933677577;3192.8563214655396;3196.0891146023273;3202.839858007137;977.0815433492494;991.3902949686036;995.576879826071;1003.6838395905412;1004.4826914139225;888.1163242573551;894.4141587260355;896.2650626486219;963.6723514005272;1119.3060302612432;6687.832804179934;6706.865862682719;6715.227748808949;6718.899216511756;6719.395254427125;598.9251343582052;730.9072935960772;1031.7936412717486;1051.673981065872;1064.9893501065046;5414;5499.257600223998;5518.089515230023;5531.668099913937;5537.169424586345;8644.394892357475;8750.03749587545;8884.466931984101;8887.73336799897;8962.73111806647;8629;8722.95638521816;8723.171298726611;8851.64593416269;8853.468791872509;6760.729570817112;6846.760363387258;6882.8623427531165;6907.067545881342;6926.8614627708175;6819.965900170468;6837.179538455417;6856.897146542906;6892.517523773488;6897.310268973062;7753.147153812964;7821.648025838737;7881.645325960231;7957.721479748181;7985.6007199638625;8085.959570202347;8087.353011758927;8159.592020399075;8162.591870406337;8169.428140030141;6727.831804204934;6781.38967492928;6834.965825170842;6836.487263455161;6867.244603093755;7333.669984850588;7389.224131466333;7390.9260907390235;7399.963000184965;7413.592252425952;6648.867022659617;6690.19717633887;6716.3955244028275;6811.93188068113;6813.4889883257965;6612.801615951529;6629;6675.332466753286;6680;6703.530752847254;6762.52662313653;6764.864702706017;6792.184937807495;6817.795466136024;6825.453963682993;5903.852403689943;5939.732712028055;5939.881202375842;5982.371850955587;5996.850078748066;5972.193753843176;6003.939960600338;6036.9698151508965;6072.757089716361;6098.451139397475 06:02:51 INFO - PROCESS | 17316 | |4;prototype.html;321.0400901305098;325.61577338740307;325.623904390429;326.8414818812875;333.1587740954092;6274.121622972782;6297.370262973706;6325.9051114233325;6328.65192414417;6433.356664333564;6237.656928868911;6239.37606239377;6259.37406259375;6270.27891792444;6282.0576913463;4666.323383109447;4680.672352935296;4687.648426368019;4728.314394412825;4741.241401375781;4736.715797052188;4738.4313882334;4738.739369334685;4740.980689151832;4747.477777444478;4571.839985600504;4611.56473755182;4624.745638989854;4686.507916668752;4710.882227944295;4672.953270467286;4675.111728771522;4679.064187162547;4692.788824502872;4696.694714843541;4047.0489434982755;4066.4510291110914;4075.1442197138635;4079.2045551117544;4080.428739976376;5896.233489646319;5983.640981541122;5988.071848863433;5990.610610310316;5995.52035837132;5403.864903377408;5434.755436005389;5460.563154947595;5508.944910550923;5519.834404967857;6603.240627327823;6644.60132392058;6650.700718467632;6659.93340066598;6669.199696036507;4519.983003824146;4524.615407690318;4527.773611319454;4530;4536.818527258905;6857.314268573103;6902.827429314257;6907.412869906064;6974.128233970804;6998.545094568837;4596.195665758479;4602.907941841211;4605.792739326738;4606.631469482433;4608.239640459354;4658.836940707059;4661.067786442725;4661.137689527448;4663.370444989951;4671.27595222741;5431.782728690887;5433.320834895638;5452.509274165344;5465.234867118606;5475.561955043587;6568.507361947873;6731.32686731323;6731.596104233761;6748.561343512656;6765.661716914135;1638.8934719243211;1652.4794689672956;1652.983470165283;1661.1030043776225;1662.1024646690894;1074.7313171707074;1077.7736675298274;1078.385320367383;1082.09644946469;1105.5025238642643;6225.782097626561;6245.375462453809;6248.9062664060075;6250.124982502453;6262.5929314594405;6889.448844092461;6909.896351554731;6920.377166055079;6920.757773478005;6936.687849046805;6144.692765361714;6247.781327653511;6259.405356491126;6306.180196574508;6314.400131987454;3758.7180961428003;3783.810809459571;3793.677537409296;3803.448499967489;3807.428885667117;7153.070100886852;7165.89251161233;7168.319009694071;7174.892376614355;7187.56874587516;7076.823079423056;7182.640867956581;7189.532680375759;7219.783406497813;7233.746818861315;7128.7504937327985;7134.857302853914;7138.857222855618;7140.143182817991;7152.463565232629;6930.445564354739;6948.270431604811;6971.337722916315;6983.580985140908;6988.40598549129;6760.526763126534;6843.144606924135;6847.281035491202;6911.067005954333;6916.3429474199875;7099.467539934422;7110.4667149962925;7141.143062832493;7150.606716630636;7158.212596614264;4663.323818046297;4687.320338550823;4702.2241330181505;4702.647301452474;4703.60019398355;6714.798556043326;6884.759033433806;6949.965250173716;7005.194402643558;7042.401395881203;6804.081449004321;6835.384815366641;6835.624040677811;6840;6844.589324640338;6640.966795165993;6776.559523630948;6811.148606424197;6814.693338799667;6831.146106736658;6648.069270302065;6654.767083152066;6659.267480577036;6666.366695163952;6676.732930682719;6838.794836154923;6848.14398200225;6849.965750171217;6859.588424694534;6865.0388945546665;6512.34876512345;6581.14445122131;6665.333466653296;6670.866582668223;6700.162479690039 06:02:51 INFO - PROCESS | 17316 | |5;yui.html;665.7403612591094;696.2480521037279;763.654419066534;770.7957391291309;797.9920200797994;12527.812082818753;12548.686282842933;12639.684007899796;12685.112042157052;12705.36473176342;11981.341026243554;12071.577494787683;12091.697707557294;12145.84614461627;12150.81773773392;681.5706105153771;690.9999999999987;692.2592825676528;702.7821375373625;727.8071311102563;670.1288325177275;672.0054319606985;680.1701923653135;683.1767719897537;688.4251649872363;706.487796347649;709.2694524639629;710.0698085507976;711.8433944532195;712.2556928010242;697.7383481194552;706.7173130747691;710.2081179484888;716.2407847681475;719.8020544350319;516.4809366586594;517.138963625563;519.0216442006806;520.0093821270485;521.8930119325568;13226.404811783494;13255;13264.73470530584;13312.534061307808;13374.465021399132;11761.58834440799;11824.467898944482;11956.461959211856;11963.820542691867;12135.696607584792;10218.846717299246;10572.101371383442;10582.576696932114;10599.894001060045;11001.339919604849;3597.1726502904216;3655.597884232732;3722.1253005543676;3736.8505259789576;3783.659470647655;45709.314360284625;45959.31061034121;46231.5376846234;46303.76848115771;46453.767731161126;9304;10027.899721002843;10142.645007424704;10265.178785697126;10561.683149505527;17267.74098388525;17452.47642570725;17472.563185920455;17604.559886002953;17651.911740441217;7212.134543854771;7424.146223184295;7470.589117598584;7570.507916985378;7603.315701586884;4200.243956087934;4203.138356636882;4210.957890421057;4257.148570285955;4262.680298977589;2883.322419231521;2923.0061778995246;2924.532074868011;2929.5605659151297;2930.721581449759;538.1658429434361;560.4927540575785;570.2358839155552;571.040651705131;571.5941681406165;557.2644109775139;605.8659286896738;614.966176860277;619.9287081985539;632.5287660692813;7440.962795185989;7739.18738532446;7745.22547745221;7855.214478552099;8039.718609848627;508.15899686019696;550.3753240072466;598.9970050149722;609.600711533946;632.5730132160774;3506.281212351462;3707.14735610811;3836.48207491985;3872.128771026553;3913.4521167036637;55128;55590.72204638951;59349.10976335358;59730;59856.70071649614;44837.327440088426;44927;45064;45394.54605453969;45713.31430028552;42820.571794281655;45897.7705111479;46604;47621.52378476171;47860;7814.921850781647;7889.605519724106;8061.879071814044;8259.38054645916;8286.129956354736;33410.832945835115;33838;34093.488597670555;34244.36176473526;34846.303073938885;38512;38794.2241155181;43849.34225986549;44192.77903610461;44488.55511444974;10106;10145.18838492904;10209.183265338606;10450.372977621368;10551.894481055399;10849.891501084889;11137.164712646421;11301;11602.560291699096;11771.11716621274;9885.901140988499;10104.646337378157;10162.18702503783;10285.485725713535;10317.535710893178;10228.897711022795;10443.582256709951;10804.24370294072;11046.834297485704;11055.336679799238;9776.511174441108;9779.804403912025;10617.575296988034;10701.197410194422;10851.131909447384;9590.376625519319;9613.510880156007;9657.855132173163;9706.75733106678;9888.505574721092;8313.916860831556;8496.787580310542;8577.914220857712;8965.193132618097;9022.86465703028 06:02:51 INFO - PROCESS | 17316 | __end_tp_report 06:02:51 INFO - PROCESS | 17316 | __start_cc_report 06:02:51 INFO - PROCESS | 17316 | _x_x_mozilla_cycle_collect,301 06:02:51 INFO - PROCESS | 17316 | __end_cc_report 06:02:51 INFO - PROCESS | 17316 | __startTimestamp1451656971776__endTimestamp 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | ------- Summary: start ------- 06:02:51 INFO - PROCESS | 17316 | Number of tests: 6 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | [#0] dojo.html Cycles:165 Average:5326.11 Median:5551.17 stddev:597.97 (10.8%) stddev-sans-first:573.65 06:02:51 INFO - PROCESS | 17316 | Values: 3096.3 3163.3 3196.2 3211.0 3215.2 5292.7 5296.9 5323.0 5327.9 5350.9 5245.7 5334.2 5354.1 5359.7 5365.1 4589.1 4843.9 5003.7 5004.8 5037.5 4801.7 4893.1 4942.3 4954.9 5009.0 4794.3 4849.3 4880.6 4900.8 4950.6 4833.6 4866.6 4876.1 4907.0 4917.6 4774.7 4848.9 4858.6 4881.1 4883.5 5132.8 5216.9 5237.1 5249.7 5260.4 5742.7 5751.9 5760.7 5774.8 5776.8 5801.2 5809.6 5818.9 5820.5 5825.7 5333.4 5361.8 5416.9 5455.0 5471.9 5815.6 5856.8 5858.8 5859.9 5892.7 5633.4 5645.5 5675.3 5697.8 5708.0 5642.9 5688.1 5713.1 5721.1 5747.2 5648.4 5713.9 5751.0 5767.7 5772.9 5640.9 5649.7 5686.5 5691.1 5698.8 4374.5 4391.5 4397.5 4399.2 4410.0 3862.9 3899.6 3917.2 3954.2 3962.7 5326.3 5386.6 5389.7 5396.3 5405.9 5844.3 5870.7 5873.6 5873.7 5875.8 5285.2 5285.5 5328.7 5351.6 5432.0 4869.5 4892.9 4899.4 4920.3 4952.2 5812.7 5813.2 5818.6 5819.6 5827.1 5690.2 5822.7 5830.6 5883.9 5924.1 5824.2 5831.8 5832.6 5862.0 5867.2 5590.3 5666.2 5682.1 5682.3 5698.0 5793.1 5815.6 5825.3 5828.9 5882.5 5561.8 5584.1 5597.8 5600.7 5624.8 5493.7 5582.1 5585.1 5589.0 5699.1 5473.9 5493.1 5556.5 5565.2 5621.5 5553.1 5619.8 5663.3 5676.0 5677.0 5419.4 5539.5 5546.1 5548.5 5551.2 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | [#1] ext.html Cycles:180 Average:43440.91 Median:34687.83 stddev:74993.16 (216.2%) stddev-sans-first:75134.28 06:02:51 INFO - PROCESS | 17316 | Values: 514.8 515.1 530.6 543.8 554.2 34006.8 34331.5 34380.5 34645.3 34657.0 35979.0 36931.8 36958.3 37008.4 37085.8 8306.1 8444.2 8503.4 8523.3 8557.7 8234.5 8240.2 8378.4 8505.3 8525.5 8488.8 8547.5 8593.0 8612.1 8624.8 8412.0 8558.9 8566.1 8573.3 8586.5 8354.3 8456.9 8493.4 8508.3 8520.5 37977.8 38059.4 38368.2 38488.4 38514.2 2599.4 3019.5 3169.1 3433.9 3675.6 24911.9 25115.2 25202.7 25431.5 25730.0 3752.5 3956.8 3975.5 4042.4 4158.4 219336.0 220109.0 221138.0 222731.0 223924.0 48182.8 49347.3 54748.5 55514.7 55803.0 49512.8 49855.5 50171.2 50222.7 50307.5 13404.1 13437.5 13472.5 13545.3 13803.8 10140.4 10229.4 10338.8 10469.9 10500.7 17990.6 18283.9 18397.8 18411.4 18445.0 7235.6 7547.0 7550.3 7583.5 7589.6 873.6 927.7 965.6 968.6 1012.7 26453.0 26719.5 26735.3 27007.5 27059.6 951.9 954.9 974.8 978.6 1007.6 13832.3 14013.6 14016.9 14113.5 14203.0 318009.0 326939.0 328327.0 328587.0 329325.0 47258.3 47622.5 47696.0 47753.3 47842.3 1231.6 1241.1 1245.7 1253.5 1256.3 25490.0 26519.3 26750.3 26795.5 27014.7 41631.0 42207.0 42322.6 42416.6 42439.0 298740.0 299631.0 299877.0 301360.0 302086.9 26291.6 26654.3 29485.6 29857.0 29863.6 34718.7 35339.3 35605.3 35821.1 36070.3 30431.7 30735.0 30749.0 30878.8 31870.5 32653.3 32769.2 32805.8 35647.8 36998.0 32573.7 32714.5 35667.8 35988.6 36090.8 27343.7 29067.9 30700.7 31227.1 31315.5 24261.0 24463.6 24663.8 24762.3 25015.6 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | [#2] jquery.html Cycles:180 Average:27944.87 Median:19851.37 stddev:87423.82 (440.4%) stddev-sans-first:87644.46 06:02:51 INFO - PROCESS | 17316 | Values: 322.1 324.8 332.2 336.2 339.1 15542.0 16083.0 16888.9 17019.4 17741.2 13834.0 13902.0 13908.4 13985.7 14041.0 4826.9 5033.9 5160.6 5174.4 5181.8 4214.6 4987.2 5042.1 5051.7 5581.9 5514.5 5527.7 5534.5 5560.9 5561.6 5538.2 5715.5 5744.6 5745.9 5747.2 5126.1 5141.4 5144.4 5148.5 5156.3 12807.8 12834.7 19143.0 19765.5 20238.3 2055.7 2074.8 2084.6 2101.9 2124.6 9229.6 9270.2 9356.7 9553.5 9563.9 1828.2 1862.9 1937.2 1970.9 1996.0 52541.7 55300.0 56520.0 58444.0 63548.0 10136.6 10227.4 10271.2 10293.2 10340.2 12270.8 12593.0 12610.4 12619.6 13007.9 6689.7 6851.8 7080.5 7185.4 7234.0 6723.6 6728.5 6832.7 6926.1 7015.0 4290.2 4379.9 4393.7 4404.5 4421.8 1790.3 1793.7 1803.8 1811.3 1844.2 388.6 392.9 411.3 830.4 865.3 9848.8 10445.1 10457.4 10594.0 10810.9 408.5 414.9 417.7 424.9 438.2 5552.0 5933.2 5974.5 9356.4 9668.7 525518.0 529513.0 536210.9 541138.0 542077.0 78115.6 78533.4 80817.6 81390.0 81643.6 1075.1 1075.9 1078.2 1078.4 1082.4 15335.9 15399.5 15524.7 15552.7 15868.3 26462.3 33659.2 34376.8 34634.0 35869.3 39309.8 40081.2 40626.8 40836.6 41770.8 9300.6 9390.6 9432.3 9609.4 9621.5 12996.7 17717.5 17846.9 18032.5 18226.0 14641.0 14742.0 14759.8 15077.8 15230.2 13792.7 13992.9 14332.3 14408.7 14786.6 14592.3 14627.9 14900.8 15064.0 15223.2 9089.5 9111.2 9378.3 9530.2 9538.1 13779.2 14225.6 14558.7 14845.8 14898.1 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | [#3] mootools.html Cycles:180 Average:5160.29 Median:6662.10 stddev:2698.83 (40.5%) stddev-sans-first:2691.35 06:02:51 INFO - PROCESS | 17316 | Values: 1368.2 1369.4 1433.7 1601.5 1610.6 7359.1 7406.2 7420.0 7476.0 7575.4 7516.8 7521.5 7547.2 7628.5 7637.3 2136.0 2182.6 2190.8 2196.8 2197.7 2157.1 2186.6 2212.7 2214.2 2216.7 2164.9 2165.4 2185.7 2212.4 2218.1 2181.0 2201.7 2215.2 2218.5 2231.3 2204.6 2242.3 2242.9 2246.7 2247.2 7371.3 7388.0 7457.0 7474.7 7492.2 4247.4 4292.8 4319.0 4326.6 4335.7 2886.0 2942.0 2950.7 2982.7 2986.8 922.9 946.2 949.9 960.1 1003.3 10178.7 10232.5 10250.4 10250.9 10259.4 3889.2 3914.9 3947.2 3949.1 3970.0 8215.1 8259.0 8275.9 8311.2 8385.1 4209.3 4294.4 4299.6 4300.5 4327.4 3898.8 3930.4 3936.8 3939.2 3963.2 3182.0 3185.2 3192.9 3196.1 3202.8 977.1 991.4 995.6 1003.7 1004.5 888.1 894.4 896.3 963.7 1119.3 6687.8 6706.9 6715.2 6718.9 6719.4 598.9 730.9 1031.8 1051.7 1065.0 5414.0 5499.3 5518.1 5531.7 5537.2 8644.4 8750.0 8884.5 8887.7 8962.7 8629.0 8723.0 8723.2 8851.6 8853.5 6760.7 6846.8 6882.9 6907.1 6926.9 6820.0 6837.2 6856.9 6892.5 6897.3 7753.1 7821.6 7881.6 7957.7 7985.6 8086.0 8087.4 8159.6 8162.6 8169.4 6727.8 6781.4 6835.0 6836.5 6867.2 7333.7 7389.2 7390.9 7400.0 7413.6 6648.9 6690.2 6716.4 6811.9 6813.5 6612.8 6629.0 6675.3 6680.0 6703.5 6762.5 6764.9 6792.2 6817.8 6825.5 5903.9 5939.7 5939.9 5982.4 5996.9 5972.2 6003.9 6037.0 6072.8 6098.5 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | [#4] prototype.html Cycles:180 Average:5568.31 Median:6266.44 stddev:1719.78 (27.4%) stddev-sans-first:1678.90 06:02:51 INFO - PROCESS | 17316 | Values: 321.0 325.6 325.6 326.8 333.2 6274.1 6297.4 6325.9 6328.7 6433.4 6237.7 6239.4 6259.4 6270.3 6282.1 4666.3 4680.7 4687.6 4728.3 4741.2 4736.7 4738.4 4738.7 4741.0 4747.5 4571.8 4611.6 4624.7 4686.5 4710.9 4673.0 4675.1 4679.1 4692.8 4696.7 4047.0 4066.5 4075.1 4079.2 4080.4 5896.2 5983.6 5988.1 5990.6 5995.5 5403.9 5434.8 5460.6 5508.9 5519.8 6603.2 6644.6 6650.7 6659.9 6669.2 4520.0 4524.6 4527.8 4530.0 4536.8 6857.3 6902.8 6907.4 6974.1 6998.5 4596.2 4602.9 4605.8 4606.6 4608.2 4658.8 4661.1 4661.1 4663.4 4671.3 5431.8 5433.3 5452.5 5465.2 5475.6 6568.5 6731.3 6731.6 6748.6 6765.7 1638.9 1652.5 1653.0 1661.1 1662.1 1074.7 1077.8 1078.4 1082.1 1105.5 6225.8 6245.4 6248.9 6250.1 6262.6 6889.4 6909.9 6920.4 6920.8 6936.7 6144.7 6247.8 6259.4 6306.2 6314.4 3758.7 3783.8 3793.7 3803.4 3807.4 7153.1 7165.9 7168.3 7174.9 7187.6 7076.8 7182.6 7189.5 7219.8 7233.7 7128.8 7134.9 7138.9 7140.1 7152.5 6930.4 6948.3 6971.3 6983.6 6988.4 6760.5 6843.1 6847.3 6911.1 6916.3 7099.5 7110.5 7141.1 7150.6 7158.2 4663.3 4687.3 4702.2 4702.6 4703.6 6714.8 6884.8 6950.0 7005.2 7042.4 6804.1 6835.4 6835.6 6840.0 6844.6 6641.0 6776.6 6811.1 6814.7 6831.1 6648.1 6654.8 6659.3 6666.4 6676.7 6838.8 6848.1 6850.0 6859.6 6865.0 6512.3 6581.1 6665.3 6670.9 6700.2 06:02:51 INFO - PROCESS | 17316 | 06:02:51 INFO - PROCESS | 17316 | [#5] yui.html Cycles:180 Average:13178.77 Median:45551.93 stddev:15367.89 (33.7%) stddev-sans-first:15382.27 06:02:51 INFO - PROCESS | 17316 | Values: 665.7 696.2 763.7 770.8 798.0 12527.8 12548.7 12639.7 12685.1 12705.4 11981.3 12071.6 12091.7 12145.8 12150.8 681.6 691.0 692.3 702.8 727.8 670.1 672.0 680.2 683.2 688.4 706.5 709.3 710.1 711.8 712.3 697.7 706.7 710.2 716.2 719.8 516.5 517.1 519.0 520.0 521.9 13226.4 13255.0 13264.7 13312.5 13374.5 11761.6 11824.5 11956.5 11963.8 12135.7 10218.8 10572.1 10582.6 10599.9 11001.3 3597.2 3655.6 3722.1 3736.9 3783.7 45709.3 45959.3 46231.5 46303.8 46453.8 9304.0 10027.9 10142.6 10265.2 10561.7 17267.7 17452.5 17472.6 17604.6 17651.9 7212.1 7424.1 7470.6 7570.5 7603.3 4200.2 4203.1 4211.0 4257.1 4262.7 2883.3 2923.0 2924.5 2929.6 2930.7 538.2 560.5 570.2 571.0 571.6 557.3 605.9 615.0 619.9 632.5 7441.0 7739.2 7745.2 7855.2 8039.7 508.2 550.4 599.0 609.6 632.6 3506.3 3707.1 3836.5 3872.1 3913.5 55128.0 55590.7 59349.1 59730.0 59856.7 44837.3 44927.0 45064.0 45394.5 45713.3 42820.6 45897.8 46604.0 47621.5 47860.0 7814.9 7889.6 8061.9 8259.4 8286.1 33410.8 33838.0 34093.5 34244.4 34846.3 38512.0 38794.2 43849.3 44192.8 44488.6 10106.0 10145.2 10209.2 10450.4 10551.9 10849.9 11137.2 11301.0 11602.6 11771.1 9885.9 10104.6 10162.2 10285.5 10317.5 10228.9 10443.6 10804.2 11046.8 11055.3 9776.5 9779.8 10617.6 10701.2 10851.1 9590.4 9613.5 9657.9 9706.8 9888.5 8313.9 8496.8 8577.9 8965.2 9022.9 06:02:51 INFO - PROCESS | 17316 | -------- Summary: end -------- 06:02:51 INFO - PROCESS | 17316 | 06:02:52 INFO - TEST-INFO | 17316: exit 0 06:02:52 INFO - TEST-OK | dromaeo_css | took 1111432ms 06:02:52 INFO - TEST-START | kraken 06:02:52 INFO - operating with platform_type : linux_ 06:02:52 INFO - Initialising browser for kraken test... 06:02:52 INFO - TEST-INFO | started process 17556 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWXCt9z/profile http://localhost:39480/getInfo.html) 06:02:57 INFO - PROCESS | 17556 | __metrics Screen width/height:1600/1200 06:02:57 INFO - PROCESS | 17556 | colorDepth:24 06:02:57 INFO - PROCESS | 17556 | Browser inner width/height: 1024/670 06:02:57 INFO - PROCESS | 17556 | __metrics 06:02:57 INFO - PROCESS | 17556 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:02:58 INFO - TEST-INFO | 17556: exit 0 06:02:58 INFO - Browser initialized. 06:02:58 INFO - Running cycle 1/1 for kraken test... 06:02:58 INFO - TEST-INFO | started process 17679 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWXCt9z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:10 INFO - PROCESS | 17679 | RSS: Main: 150016000 06:03:10 INFO - PROCESS | 17679 | 06:03:13 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39480/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:13 INFO - PROCESS | 17679 | RSS: Main: 150913024 06:03:13 INFO - PROCESS | 17679 | 06:03:16 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39480/tests/kraken/driver.html?testName=audio-dft) 06:03:16 INFO - PROCESS | 17679 | RSS: Main: 151629824 06:03:16 INFO - PROCESS | 17679 | 06:03:19 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39480/tests/kraken/driver.html?testName=audio-fft) 06:03:20 INFO - PROCESS | 17679 | RSS: Main: 146640896 06:03:20 INFO - PROCESS | 17679 | 06:03:22 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39480/tests/kraken/driver.html?testName=audio-oscillator) 06:03:22 INFO - PROCESS | 17679 | RSS: Main: 146657280 06:03:22 INFO - PROCESS | 17679 | 06:03:25 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:25 INFO - PROCESS | 17679 | RSS: Main: 147005440 06:03:25 INFO - PROCESS | 17679 | 06:03:28 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39480/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:29 INFO - PROCESS | 17679 | RSS: Main: 145960960 06:03:29 INFO - PROCESS | 17679 | 06:03:32 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39480/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:33 INFO - PROCESS | 17679 | RSS: Main: 149200896 06:03:33 INFO - PROCESS | 17679 | 06:03:36 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39480/tests/kraken/driver.html?testName=json-parse-financial) 06:03:36 INFO - PROCESS | 17679 | RSS: Main: 148353024 06:03:36 INFO - PROCESS | 17679 | 06:03:38 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:38 INFO - PROCESS | 17679 | RSS: Main: 148013056 06:03:38 INFO - PROCESS | 17679 | 06:03:40 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:41 INFO - PROCESS | 17679 | RSS: Main: 148639744 06:03:41 INFO - PROCESS | 17679 | 06:03:43 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:43 INFO - PROCESS | 17679 | RSS: Main: 149127168 06:03:43 INFO - PROCESS | 17679 | 06:03:46 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:47 INFO - PROCESS | 17679 | RSS: Main: 148889600 06:03:47 INFO - PROCESS | 17679 | 06:03:49 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:50 INFO - PROCESS | 17679 | RSS: Main: 148422656 06:03:50 INFO - PROCESS | 17679 | 06:03:51 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:39480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39480/tests/kraken/driver.html?testName=ai-astar) 06:03:52 INFO - PROCESS | 17679 | RSS: Main: 147767296 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | __start_tp_report 06:03:52 INFO - PROCESS | 17679 | _x_x_mozilla_page_load 06:03:52 INFO - PROCESS | 17679 | _x_x_mozilla_page_load_details 06:03:52 INFO - PROCESS | 17679 | |i|pagename|runs| 06:03:52 INFO - PROCESS | 17679 | |0;ai-astar;111;107;114;111;111;123;112;112;113;113 06:03:52 INFO - PROCESS | 17679 | |1;audio-beat-detection;150;123;150;165;128;153;156;127;164;126 06:03:52 INFO - PROCESS | 17679 | |2;audio-dft;163;162;162;161;163;165;162;167;168;161 06:03:52 INFO - PROCESS | 17679 | |3;audio-fft;73;74;72;73;74;83;75;72;153;74 06:03:52 INFO - PROCESS | 17679 | |4;audio-oscillator;96;96;142;96;95;97;143;98;97;148 06:03:52 INFO - PROCESS | 17679 | |5;imaging-gaussian-blur;110;109;109;109;110;110;110;110;110;111 06:03:52 INFO - PROCESS | 17679 | |6;imaging-darkroom;146;148;147;146;145;146;151;146;146;146 06:03:52 INFO - PROCESS | 17679 | |7;imaging-desaturate;96;96;98;97;96;105;96;96;97;97 06:03:52 INFO - PROCESS | 17679 | |8;json-parse-financial;57;57;58;58;57;57;58;57;58;56 06:03:52 INFO - PROCESS | 17679 | |9;json-stringify-tinderbox;69;70;71;69;69;69;72;69;70;69 06:03:52 INFO - PROCESS | 17679 | |10;stanford-crypto-aes;85;88;95;87;85;87;87;87;89;91 06:03:52 INFO - PROCESS | 17679 | |11;stanford-crypto-ccm;124;122;119;122;125;119;135;127;131;119 06:03:52 INFO - PROCESS | 17679 | |12;stanford-crypto-pbkdf2;139;153;157;151;152;140;152;149;151;139 06:03:52 INFO - PROCESS | 17679 | |13;stanford-crypto-sha256-iterative;69;69;69;70;70;70;68;69;71;69 06:03:52 INFO - PROCESS | 17679 | __end_tp_report 06:03:52 INFO - PROCESS | 17679 | __start_cc_report 06:03:52 INFO - PROCESS | 17679 | _x_x_mozilla_cycle_collect,744 06:03:52 INFO - PROCESS | 17679 | __end_cc_report 06:03:52 INFO - PROCESS | 17679 | __startTimestamp1451657032146__endTimestamp 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | ------- Summary: start ------- 06:03:52 INFO - PROCESS | 17679 | Number of tests: 14 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:4.08 (3.6%) stddev-sans-first:4.28 06:03:52 INFO - PROCESS | 17679 | Values: 111.0 107.0 114.0 111.0 111.0 123.0 112.0 112.0 113.0 113.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.50 stddev:16.49 (10.9%) stddev-sans-first:17.36 06:03:52 INFO - PROCESS | 17679 | Values: 150.0 123.0 150.0 165.0 128.0 153.0 156.0 127.0 164.0 126.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.46 (1.5%) stddev-sans-first:2.60 06:03:52 INFO - PROCESS | 17679 | Values: 163.0 162.0 162.0 161.0 163.0 165.0 162.0 167.0 168.0 161.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#3] audio-fft Cycles:10 Average:82.30 Median:74.00 stddev:25.04 (33.8%) stddev-sans-first:26.33 06:03:52 INFO - PROCESS | 17679 | Values: 73.0 74.0 72.0 73.0 74.0 83.0 75.0 72.0 153.0 74.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:96.00 stddev:23.20 (24.2%) stddev-sans-first:23.98 06:03:52 INFO - PROCESS | 17679 | Values: 96.0 96.0 142.0 96.0 95.0 97.0 143.0 98.0 97.0 148.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 06:03:52 INFO - PROCESS | 17679 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 111.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.00 stddev:1.70 (1.2%) stddev-sans-first:1.79 06:03:52 INFO - PROCESS | 17679 | Values: 146.0 148.0 147.0 146.0 145.0 146.0 151.0 146.0 146.0 146.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:96.50 stddev:2.76 (2.9%) stddev-sans-first:2.88 06:03:52 INFO - PROCESS | 17679 | Values: 96.0 96.0 98.0 97.0 96.0 105.0 96.0 96.0 97.0 97.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 06:03:52 INFO - PROCESS | 17679 | Values: 57.0 57.0 58.0 58.0 57.0 57.0 58.0 57.0 58.0 56.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:1.06 (1.5%) stddev-sans-first:1.09 06:03:52 INFO - PROCESS | 17679 | Values: 69.0 70.0 71.0 69.0 69.0 69.0 72.0 69.0 70.0 69.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:87.50 stddev:3.00 (3.4%) stddev-sans-first:2.96 06:03:52 INFO - PROCESS | 17679 | Values: 85.0 88.0 95.0 87.0 85.0 87.0 87.0 87.0 89.0 91.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:124.50 stddev:5.40 (4.3%) stddev-sans-first:5.72 06:03:52 INFO - PROCESS | 17679 | Values: 124.0 122.0 119.0 122.0 125.0 119.0 135.0 127.0 131.0 119.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:151.50 stddev:6.52 (4.3%) stddev-sans-first:5.98 06:03:52 INFO - PROCESS | 17679 | Values: 139.0 153.0 157.0 151.0 152.0 140.0 152.0 149.0 151.0 139.0 06:03:52 INFO - PROCESS | 17679 | 06:03:52 INFO - PROCESS | 17679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 06:03:52 INFO - PROCESS | 17679 | Values: 69.0 69.0 69.0 70.0 70.0 70.0 68.0 69.0 71.0 69.0 06:03:52 INFO - PROCESS | 17679 | -------- Summary: end -------- 06:03:52 INFO - PROCESS | 17679 | 06:03:53 INFO - TEST-INFO | 17679: exit 0 06:03:53 INFO - TEST-OK | kraken | took 60450ms 06:03:53 INFO - TEST-START | v8_7 06:03:53 INFO - operating with platform_type : linux_ 06:03:53 INFO - Initialising browser for v8_7 test... 06:03:53 INFO - TEST-INFO | started process 17965 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeCEeZ8/profile http://localhost:39480/getInfo.html) 06:03:58 INFO - PROCESS | 17965 | __metrics Screen width/height:1600/1200 06:03:58 INFO - PROCESS | 17965 | colorDepth:24 06:03:58 INFO - PROCESS | 17965 | Browser inner width/height: 1024/670 06:03:58 INFO - PROCESS | 17965 | __metrics 06:03:58 INFO - PROCESS | 17965 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:03:59 INFO - TEST-INFO | 17965: exit 0 06:03:59 INFO - Browser initialized. 06:03:59 INFO - Running cycle 1/1 for v8_7 test... 06:03:59 INFO - TEST-INFO | started process 18087 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeCEeZ8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:11 INFO - PROCESS | 18087 | RSS: Main: 150032384 06:04:11 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:39480/tests/v8_7/run.html (next: http://localhost:39480/tests/v8_7/run.html) 06:04:32 INFO - PROCESS | 18087 | RSS: Main: 146194432 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | __start_tp_report 06:04:32 INFO - PROCESS | 18087 | _x_x_mozilla_page_load 06:04:32 INFO - PROCESS | 18087 | _x_x_mozilla_page_load_details 06:04:32 INFO - PROCESS | 18087 | |i|pagename|runs| 06:04:32 INFO - PROCESS | 18087 | |0;Richards;169.26201760324983 06:04:32 INFO - PROCESS | 18087 | |1;DeltaBlue;190.91256204658268 06:04:32 INFO - PROCESS | 18087 | |2;Encrypt;281.29395218002816 06:04:32 INFO - PROCESS | 18087 | |3;Decrypt;5208.333333333333 06:04:32 INFO - PROCESS | 18087 | |4;RayTrace;1061.5711252653928 06:04:32 INFO - PROCESS | 18087 | |5;Earley;710.7320540156361 06:04:32 INFO - PROCESS | 18087 | |6;Boyer;12444.444444444445 06:04:32 INFO - PROCESS | 18087 | |7;RegExp;25300 06:04:32 INFO - PROCESS | 18087 | |8;Splay;689.6551724137931 06:04:32 INFO - PROCESS | 18087 | |9;NavierStokes;4859.223300970873 06:04:32 INFO - PROCESS | 18087 | __end_tp_report 06:04:32 INFO - PROCESS | 18087 | __startTimestamp1451657072739__endTimestamp 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | ------- Summary: start ------- 06:04:32 INFO - PROCESS | 18087 | Number of tests: 10 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#0] Richards Cycles:1 Average:169.26 Median:169.26 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 169.3 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#1] DeltaBlue Cycles:1 Average:190.91 Median:190.91 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 190.9 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 281.3 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 5208.3 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 1061.6 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#5] Earley Cycles:1 Average:710.73 Median:710.73 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 710.7 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 12444.4 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#7] RegExp Cycles:1 Average:25300.00 Median:25300.00 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 25300.0 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#8] Splay Cycles:1 Average:689.66 Median:689.66 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 689.7 06:04:32 INFO - PROCESS | 18087 | 06:04:32 INFO - PROCESS | 18087 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 06:04:32 INFO - PROCESS | 18087 | Values: 4859.2 06:04:32 INFO - PROCESS | 18087 | -------- Summary: end -------- 06:04:32 INFO - PROCESS | 18087 | 06:04:33 INFO - TEST-INFO | 18087: exit 0 06:04:33 INFO - TEST-OK | v8_7 | took 40549ms 06:04:33 INFO - SUITE-END | took 1212s 06:04:33 INFO - Completed test suite (00:20:12) 06:04:33 INFO - Working with test: dromaeo_css 06:04:33 INFO - Generating results file: dromaeo_css 06:04:33 INFO - Working with test: kraken 06:04:33 INFO - Generating results file: kraken 06:04:33 INFO - javascript benchmark 06:04:33 INFO - Working with test: v8_7 06:04:33 INFO - Generating results file: v8_7 06:04:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:04:33 INFO - process_Request line: dromaeo_css 6715.46 graph.html#tests=[[72,1,43]] 06:04:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:34 INFO - process_Request line: kraken 1524.40 graph.html#tests=[[232,1,43]] 06:04:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:34 INFO - process_Request line: v8_7 20983.38 graph.html#tests=[[230,1,43]] 06:04:34 INFO - RETURN: dromaeo_css: 6715.46 06:04:34 INFO - RETURN: kraken: 1524.40 06:04:34 INFO - RETURN: v8_7: 20983.38 06:04:34 INFO - javascript benchmark 06:04:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3096.3497665490245, 3163.272447337114, 3196.2169268529215, 3211.036688993302, 3215.228345197152, 5292.655977361469, 5296.867578310545, 5323.0, 5327.866803329919, 5350.946490535103, 5245.659032162906, 5334.226537152111, 5354.089804733195, 5359.732013399324, 5365.141577347626, 4589.105124500724, 4843.854684359475, 5003.724795136266, 5004.824831130911, 5037.49625037497, 4801.711897286156, 4893.070316639845, 4942.308076869242, 4954.87612809679, 5009.0, 4794.280857871329, 4849.321095046696, 4880.633952453581, 4900.803967841282, 4950.579200767921, 4833.637477189225, 4866.6106711463, 4876.146674332013, 4907.0, 4917.557419832232, 4774.73738944358, 4848.878778030542, 4858.611311095104, 4881.0725962067445, 4883.511648835123, 5132.820351287687, 5216.895662086737, 5237.083510385667, 5249.737513124329, 5260.447652996419, 5742.6841523716175, 5751.942480575182, 5760.683162426065, 5774.82675519735, 5776.797812076599, 5801.187833703285, 5809.564282678816, 5818.912716309259, 5820.505257053113, 5825.708714564297, 5333.439988801198, 5361.839144825662, 5416.864578385533, 5455.0453670607885, 5471.917921231185, 5815.621984570989, 5856.795012174639, 5858.765649374062, 5859.912101318484, 5892.705364731832, 5633.352164501053, 5645.491905728504, 5675.347335056521, 5697.800576979786, 5708.0, 5642.943570564242, 5688.06146985751, 5713.114467257582, 5721.141828725641, 5747.166660834156, 5648.350439699405, 5713.885722285614, 5751.0, 5767.711614419346, 5772.855678608068, 5640.887182256414, 5649.745761440745, 5686.488216060575, 5691.089425691869, 5698.772049118072, 4374.518802931675, 4391.538888416734, 4397.472303323558, 4399.1641588098155, 4409.955900440955, 3862.9034274143373, 3899.6100389960775, 3917.1578110706337, 3954.189391174802, 3962.742421742635, 5326.334208223972, 5386.569074474032, 5389.703566303812, 5396.325459317585, 5405.864853378697, 5844.298684157929, 5870.6771127587535, 5873.618214816109, 5873.676947767828, 5875.794347197913, 5285.180796976475, 5285.524302812765, 5328.706921119298, 5351.5718742501285, 5431.972840135774, 4869.537393947569, 4892.926606100911, 4899.387576552931, 4920.3111564381015, 4952.20764677657, 5812.680302583399, 5813.215215945877, 5818.6217895836635, 5819.592628516048, 5827.067669172912, 5690.231818704422, 5822.679752613647, 5830.5627077968475, 5883.94116058834, 5924.11138329254, 5824.242848429677, 5831.79588714393, 5832.591718579828, 5862.0, 5867.178594996619, 5590.273264475755, 5666.17840413146, 5682.090865461506, 5682.318121825408, 5697.971510142423, 5793.073108302651, 5815.5929084963645, 5825.271841019872, 5828.912566311594, 5882.5293976480925, 5561.805336813192, 5584.106542953108, 5597.776088956559, 5600.663960162403, 5624.775008999594, 5493.725313734218, 5582.051051321204, 5585.106382978866, 5588.972055139861, 5699.088145896802, 5473.863153421196, 5493.121100623881, 5556.472135147154, 5565.220869078251, 5621.494065534122, 5553.08374118266, 5619.831405057855, 5663.32040155184, 5676.0, 5677.034904066236, 5419.430959749169, 5539.529140023144, 5546.140348246028, 5548.528375088163, 5551.1673249011355], "unit": "score", "name": "dojo.html", "value": 5286.681297344667}, {"lowerIsBetter": false, "replicates": [514.8095204774235, 515.0651567405159, 530.5887936848942, 543.8205392220563, 554.2019491931618, 34006.829965850164, 34331.48502772454, 34380.484292735564, 34645.30709385814, 34657.0, 35979.0, 36931.81534092333, 36958.26083478335, 37008.444873326924, 37085.81457092718, 8306.127856575078, 8444.240018398343, 8503.447275927076, 8523.275521580643, 8557.743267701948, 8234.505929644241, 8240.21717936795, 8378.371622128334, 8505.31957443403, 8525.531095789729, 8488.78778030548, 8547.487150770943, 8592.957035214815, 8612.052674205863, 8624.827503449927, 8411.95794021029, 8558.914410855874, 8566.143385661446, 8573.271271941892, 8586.484810911365, 8354.289885359753, 8456.8731469028, 8493.447925884859, 8508.319334453228, 8520.488770673717, 37977.81011094955, 38059.429108563396, 38368.232635347136, 38488.422673659916, 38514.229715405534, 2599.415131595395, 3019.5168772996435, 3169.065125787898, 3433.9313213735586, 3675.5773086095173, 24911.87544062286, 25115.246542603752, 25202.747972520225, 25431.491370172676, 25730.0, 3752.4934133891848, 3956.7625942443256, 3975.5428125765616, 4042.353223484258, 4158.438610787535, 219336.0, 220109.0, 221138.0, 222731.0, 223924.0, 48182.75908620434, 49347.25979110316, 54748.45251547513, 55514.72242638761, 55803.0, 49512.79141273032, 49855.50144498581, 50171.24743128856, 50222.748886256064, 50307.49692503028, 13404.128731632607, 13437.529686461123, 13472.461101555828, 13545.322733863268, 13803.792943105862, 10140.442275674908, 10229.386236825814, 10338.844917326247, 10469.9476502617, 10500.73748156287, 17990.550236243937, 18283.90858045728, 18397.816021839877, 18411.447656570323, 18445.0, 7235.565866048054, 7546.9622651887485, 7550.282723141293, 7583.544987300779, 7589.620518974029, 873.567115583098, 927.7170463008712, 965.6089283839916, 968.6222373274429, 1012.7468132966758, 26453.0, 26719.46561068768, 26735.251727051647, 27007.459850802872, 27059.594106088425, 951.9190868776093, 954.9447860114612, 974.8245315843217, 978.6036655154674, 1007.6019972110975, 13832.308384580932, 14013.579592612237, 14016.929915350358, 14113.5060272892, 14203.0, 318009.0, 326939.0, 328327.0, 328587.0, 329325.0, 47258.29112563314, 47622.5237747625, 47696.0, 47753.28370074452, 47842.28236576454, 1231.5997300877073, 1241.0567968344124, 1245.725940293134, 1253.4547471849592, 1256.2901960392348, 25490.0, 26519.33701657474, 26750.331241719112, 26795.464090717687, 27014.72985270122, 41631.0, 42207.0, 42322.576774231864, 42416.57583424126, 42439.0, 298740.0, 299631.0, 299877.0, 301360.0, 302086.8956552208, 26291.60562591601, 26654.333641659112, 29485.557716633837, 29857.0, 29863.552046718884, 34718.65281347255, 35339.29321413609, 35605.28789424249, 35821.134309254674, 36070.27859442744, 30431.69568304377, 30735.0, 30749.0, 30878.84560577183, 31870.52194217135, 32653.346933061683, 32769.180770480925, 32805.83597081999, 35647.82176089103, 36998.0, 32573.674263258014, 32714.509282360308, 35667.82166089153, 35988.64011359853, 36090.8195459021, 27343.72656273412, 29067.900557444493, 30700.65841662757, 31227.063188104392, 31315.53026704647, 24261.0, 24463.633045503975, 24663.7734284873, 24762.25713228606, 25015.624765628894], "unit": "score", "name": "ext.html", "value": 17113.52591426191}, {"lowerIsBetter": false, "replicates": [322.10615541871306, 324.80998615809744, 332.1612927358421, 336.238419978748, 339.13858798651427, 15542.0, 16083.0, 16888.915555422238, 17019.404320848742, 17741.201645925932, 13834.0, 13902.0, 13908.374123164456, 13985.720285594307, 14041.017128800988, 4826.855194344175, 5033.899322013557, 5160.587153027749, 5174.379074511064, 5181.792728290864, 4214.599613036757, 4987.1521841286885, 5042.067217564744, 5051.696898186102, 5581.944180558183, 5514.476124768141, 5527.695976721278, 5534.501894829465, 5560.916586251209, 5561.555075593943, 5538.196961440589, 5715.457031581993, 5744.597878148531, 5745.856353591152, 5747.2241247431475, 5126.051680439131, 5141.434442211354, 5144.408393034774, 5148.536631703128, 5156.303898973628, 12807.807882881763, 12834.743305133938, 19143.0, 19765.505862353413, 20238.291659791983, 2055.732754741874, 2074.761402438724, 2084.6143463459307, 2101.8528702990798, 2124.6281900667323, 9229.584668689926, 9270.21203197729, 9356.672516461891, 9553.522323883779, 9563.856542151872, 1828.2321425001398, 1862.9347972820885, 1937.1670181821812, 1970.881747095179, 1995.950101247466, 52541.73729131368, 55300.0, 56520.0, 58444.0, 63548.04677929881, 10136.594536218468, 10227.386356818615, 10271.229657775697, 10293.176545876311, 10340.172786177087, 12270.754584908253, 12593.0, 12610.432530536147, 12619.558315458915, 13007.869921300666, 6689.6989635466525, 6851.760188393382, 7080.539764915264, 7185.353318201387, 7234.0, 6723.63020033893, 6728.529002969843, 6832.658367081626, 6926.06498122747, 7014.964925175342, 4290.184864875664, 4379.868603941887, 4393.736375817397, 4404.515503294635, 4421.7789110544345, 1790.2838864454322, 1793.6771381151518, 1803.8376546110912, 1811.275489804089, 1844.1977739683011, 388.5880966175806, 392.9390944403622, 411.28847094526037, 830.3772170871846, 865.3077537969599, 9848.803023939481, 10445.11216546587, 10457.372557646566, 10594.0, 10810.891891081146, 408.51998901290864, 414.93153629651374, 417.70551761008414, 424.9171411574775, 438.23746680775224, 5551.9722401387735, 5933.169356290123, 5974.462298393166, 9356.4386136832, 9668.70993870185, 525518.0, 529513.0, 536210.9136725904, 541138.0, 542077.0, 78115.60942195366, 78533.42933141305, 80817.59591202006, 81390.0, 81643.5917820419, 1075.1398880895254, 1075.8977897099762, 1078.1698092468755, 1078.412265315405, 1082.4154956323655, 15335.923320383326, 15399.461018864286, 15524.689506209586, 15552.688946221238, 15868.285927133538, 26462.338441538344, 33659.15852103619, 34376.82811585926, 34634.0, 35869.282614347045, 39309.80345098256, 40081.1983760329, 40626.79686601548, 40836.59163408447, 41770.791146044074, 9300.581473833558, 9390.624375024923, 9432.339736218673, 9609.375390599589, 9621.51892405363, 12996.675083122998, 17717.46847594574, 17846.91076544609, 18032.459026229233, 18226.0, 14641.0, 14742.0, 14759.778603321174, 15077.773833392288, 15230.162341071347, 13792.724145517233, 13992.930035349758, 14332.283385830875, 14408.711825763216, 14786.63033424173, 14592.343344549734, 14627.92686036563, 14900.7764883529, 15064.0, 15223.238838058274, 9089.454632722058, 9111.17999380059, 9378.343515953818, 9530.237580993642, 9538.141567258703, 13779.173249605055, 14225.644358890697, 14558.708825823212, 14845.777313340093, 14898.106113633217], "unit": "score", "name": "jquery.html", "value": 8170.7471711770995}, {"lowerIsBetter": false, "replicates": [1368.1927662679018, 1369.3564024908292, 1433.7060902514986, 1601.4715144002466, 1610.5973506623345, 7359.116905971277, 7406.222346653598, 7419.962900185505, 7475.99074124993, 7575.356094731947, 7516.774496765106, 7521.548707077579, 7547.169811320764, 7628.5041472304265, 7637.274458926393, 2136.0387825478556, 2182.563487302546, 2190.8466407351493, 2196.8352373572047, 2197.670349447588, 2157.094020511389, 2186.6173419651495, 2212.734471863371, 2214.1586197245024, 2216.6896634471186, 2164.880931548772, 2165.415337858777, 2185.65029595264, 2212.4358288636454, 2218.0684112672716, 2180.9781902180935, 2201.6917631531596, 2215.1582398688556, 2218.5230175512343, 2231.263682984611, 2204.5921504521716, 2242.3048854854883, 2242.887855607213, 2246.7416247131628, 2247.224707475918, 7371.299726525972, 7388.0, 7457.030586023782, 7474.663640136207, 7492.175860655324, 4247.362895565659, 4292.806823692941, 4318.978405107954, 4326.5673432656795, 4335.739855608642, 2886.0476042906002, 2942.029130386967, 2950.6606740224934, 2982.7017298270216, 2986.835724035177, 922.944623322596, 946.2382781860599, 949.943003419797, 960.0543464687278, 1003.3377970539482, 10178.745531361701, 10232.488375581266, 10250.436226007567, 10250.897491025069, 10259.384436933808, 3889.2415978883846, 3914.8629797956933, 3947.2302900934615, 3949.0917089069676, 3969.960300397017, 8215.137410571924, 8258.958705206556, 8275.875861861956, 8311.210435008665, 8385.077641459435, 4209.326507758744, 4294.377315289265, 4299.570042995738, 4300.483941926988, 4327.37253098299, 3898.8440462381755, 3930.3514920037874, 3936.822842972073, 3939.153082087365, 3963.207358528306, 3181.9681803182134, 3185.155933677577, 3192.8563214655396, 3196.0891146023273, 3202.839858007137, 977.0815433492494, 991.3902949686036, 995.576879826071, 1003.6838395905412, 1004.4826914139225, 888.1163242573551, 894.4141587260355, 896.2650626486219, 963.6723514005272, 1119.3060302612432, 6687.832804179934, 6706.865862682719, 6715.227748808949, 6718.899216511756, 6719.395254427125, 598.9251343582052, 730.9072935960772, 1031.7936412717486, 1051.673981065872, 1064.9893501065046, 5414.0, 5499.257600223998, 5518.089515230023, 5531.668099913937, 5537.169424586345, 8644.394892357475, 8750.03749587545, 8884.466931984101, 8887.73336799897, 8962.73111806647, 8629.0, 8722.95638521816, 8723.171298726611, 8851.64593416269, 8853.468791872509, 6760.729570817112, 6846.760363387258, 6882.8623427531165, 6907.067545881342, 6926.8614627708175, 6819.965900170468, 6837.179538455417, 6856.897146542906, 6892.517523773488, 6897.310268973062, 7753.147153812964, 7821.648025838737, 7881.645325960231, 7957.721479748181, 7985.6007199638625, 8085.959570202347, 8087.353011758927, 8159.592020399075, 8162.591870406337, 8169.428140030141, 6727.831804204934, 6781.38967492928, 6834.965825170842, 6836.487263455161, 6867.244603093755, 7333.669984850588, 7389.224131466333, 7390.9260907390235, 7399.963000184965, 7413.592252425952, 6648.867022659617, 6690.19717633887, 6716.3955244028275, 6811.93188068113, 6813.4889883257965, 6612.801615951529, 6629.0, 6675.332466753286, 6680.0, 6703.530752847254, 6762.52662313653, 6764.864702706017, 6792.184937807495, 6817.795466136024, 6825.453963682993, 5903.852403689943, 5939.732712028055, 5939.881202375842, 5982.371850955587, 5996.850078748066, 5972.193753843176, 6003.939960600338, 6036.9698151508965, 6072.757089716361, 6098.451139397475], "unit": "score", "name": "mootools.html", "value": 4203.73927488084}, {"lowerIsBetter": false, "replicates": [321.0400901305098, 325.61577338740307, 325.623904390429, 326.8414818812875, 333.1587740954092, 6274.121622972782, 6297.370262973706, 6325.9051114233325, 6328.65192414417, 6433.356664333564, 6237.656928868911, 6239.37606239377, 6259.37406259375, 6270.27891792444, 6282.0576913463, 4666.323383109447, 4680.672352935296, 4687.648426368019, 4728.314394412825, 4741.241401375781, 4736.715797052188, 4738.4313882334, 4738.739369334685, 4740.980689151832, 4747.477777444478, 4571.839985600504, 4611.56473755182, 4624.745638989854, 4686.507916668752, 4710.882227944295, 4672.953270467286, 4675.111728771522, 4679.064187162547, 4692.788824502872, 4696.694714843541, 4047.0489434982755, 4066.4510291110914, 4075.1442197138635, 4079.2045551117544, 4080.428739976376, 5896.233489646319, 5983.640981541122, 5988.071848863433, 5990.610610310316, 5995.52035837132, 5403.864903377408, 5434.755436005389, 5460.563154947595, 5508.944910550923, 5519.834404967857, 6603.240627327823, 6644.60132392058, 6650.700718467632, 6659.93340066598, 6669.199696036507, 4519.983003824146, 4524.615407690318, 4527.773611319454, 4530.0, 4536.818527258905, 6857.314268573103, 6902.827429314257, 6907.412869906064, 6974.128233970804, 6998.545094568837, 4596.195665758479, 4602.907941841211, 4605.792739326738, 4606.631469482433, 4608.239640459354, 4658.836940707059, 4661.067786442725, 4661.137689527448, 4663.370444989951, 4671.27595222741, 5431.782728690887, 5433.320834895638, 5452.509274165344, 5465.234867118606, 5475.561955043587, 6568.507361947873, 6731.32686731323, 6731.596104233761, 6748.561343512656, 6765.661716914135, 1638.8934719243211, 1652.4794689672956, 1652.983470165283, 1661.1030043776225, 1662.1024646690894, 1074.7313171707074, 1077.7736675298274, 1078.385320367383, 1082.09644946469, 1105.5025238642643, 6225.782097626561, 6245.375462453809, 6248.9062664060075, 6250.124982502453, 6262.5929314594405, 6889.448844092461, 6909.896351554731, 6920.377166055079, 6920.757773478005, 6936.687849046805, 6144.692765361714, 6247.781327653511, 6259.405356491126, 6306.180196574508, 6314.400131987454, 3758.7180961428003, 3783.810809459571, 3793.677537409296, 3803.448499967489, 3807.428885667117, 7153.070100886852, 7165.89251161233, 7168.319009694071, 7174.892376614355, 7187.56874587516, 7076.823079423056, 7182.640867956581, 7189.532680375759, 7219.783406497813, 7233.746818861315, 7128.7504937327985, 7134.857302853914, 7138.857222855618, 7140.143182817991, 7152.463565232629, 6930.445564354739, 6948.270431604811, 6971.337722916315, 6983.580985140908, 6988.40598549129, 6760.526763126534, 6843.144606924135, 6847.281035491202, 6911.067005954333, 6916.3429474199875, 7099.467539934422, 7110.4667149962925, 7141.143062832493, 7150.606716630636, 7158.212596614264, 4663.323818046297, 4687.320338550823, 4702.2241330181505, 4702.647301452474, 4703.60019398355, 6714.798556043326, 6884.759033433806, 6949.965250173716, 7005.194402643558, 7042.401395881203, 6804.081449004321, 6835.384815366641, 6835.624040677811, 6840.0, 6844.589324640338, 6640.966795165993, 6776.559523630948, 6811.148606424197, 6814.693338799667, 6831.146106736658, 6648.069270302065, 6654.767083152066, 6659.267480577036, 6666.366695163952, 6676.732930682719, 6838.794836154923, 6848.14398200225, 6849.965750171217, 6859.588424694534, 6865.0388945546665, 6512.34876512345, 6581.14445122131, 6665.333466653296, 6670.866582668223, 6700.162479690039], "unit": "score", "name": "prototype.html", "value": 4997.161732091852}, {"lowerIsBetter": false, "replicates": [665.7403612591094, 696.2480521037279, 763.654419066534, 770.7957391291309, 797.9920200797994, 12527.812082818753, 12548.686282842933, 12639.684007899796, 12685.112042157052, 12705.36473176342, 11981.341026243554, 12071.577494787683, 12091.697707557294, 12145.84614461627, 12150.81773773392, 681.5706105153771, 690.9999999999987, 692.2592825676528, 702.7821375373625, 727.8071311102563, 670.1288325177275, 672.0054319606985, 680.1701923653135, 683.1767719897537, 688.4251649872363, 706.487796347649, 709.2694524639629, 710.0698085507976, 711.8433944532195, 712.2556928010242, 697.7383481194552, 706.7173130747691, 710.2081179484888, 716.2407847681475, 719.8020544350319, 516.4809366586594, 517.138963625563, 519.0216442006806, 520.0093821270485, 521.8930119325568, 13226.404811783494, 13255.0, 13264.73470530584, 13312.534061307808, 13374.465021399132, 11761.58834440799, 11824.467898944482, 11956.461959211856, 11963.820542691867, 12135.696607584792, 10218.846717299246, 10572.101371383442, 10582.576696932114, 10599.894001060045, 11001.339919604849, 3597.1726502904216, 3655.597884232732, 3722.1253005543676, 3736.8505259789576, 3783.659470647655, 45709.314360284625, 45959.31061034121, 46231.5376846234, 46303.76848115771, 46453.767731161126, 9304.0, 10027.899721002843, 10142.645007424704, 10265.178785697126, 10561.683149505527, 17267.74098388525, 17452.47642570725, 17472.563185920455, 17604.559886002953, 17651.911740441217, 7212.134543854771, 7424.146223184295, 7470.589117598584, 7570.507916985378, 7603.315701586884, 4200.243956087934, 4203.138356636882, 4210.957890421057, 4257.148570285955, 4262.680298977589, 2883.322419231521, 2923.0061778995246, 2924.532074868011, 2929.5605659151297, 2930.721581449759, 538.1658429434361, 560.4927540575785, 570.2358839155552, 571.040651705131, 571.5941681406165, 557.2644109775139, 605.8659286896738, 614.966176860277, 619.9287081985539, 632.5287660692813, 7440.962795185989, 7739.18738532446, 7745.22547745221, 7855.214478552099, 8039.718609848627, 508.15899686019696, 550.3753240072466, 598.9970050149722, 609.600711533946, 632.5730132160774, 3506.281212351462, 3707.14735610811, 3836.48207491985, 3872.128771026553, 3913.4521167036637, 55128.0, 55590.72204638951, 59349.10976335358, 59730.0, 59856.70071649614, 44837.327440088426, 44927.0, 45064.0, 45394.54605453969, 45713.31430028552, 42820.571794281655, 45897.7705111479, 46604.0, 47621.52378476171, 47860.0, 7814.921850781647, 7889.605519724106, 8061.879071814044, 8259.38054645916, 8286.129956354736, 33410.832945835115, 33838.0, 34093.488597670555, 34244.36176473526, 34846.303073938885, 38512.0, 38794.2241155181, 43849.34225986549, 44192.77903610461, 44488.55511444974, 10106.0, 10145.18838492904, 10209.183265338606, 10450.372977621368, 10551.894481055399, 10849.891501084889, 11137.164712646421, 11301.0, 11602.560291699096, 11771.11716621274, 9885.901140988499, 10104.646337378157, 10162.18702503783, 10285.485725713535, 10317.535710893178, 10228.897711022795, 10443.582256709951, 10804.24370294072, 11046.834297485704, 11055.336679799238, 9776.511174441108, 9779.804403912025, 10617.575296988034, 10701.197410194422, 10851.131909447384, 9590.376625519319, 9613.510880156007, 9657.855132173163, 9706.75733106678, 9888.505574721092, 8313.916860831556, 8496.787580310542, 8577.914220857712, 8965.193132618097, 9022.86465703028], "unit": "score", "name": "yui.html", "value": 5905.76256545789}], "name": "dromaeo_css", "value": 6715.463506477727}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 114.0, 111.0, 111.0, 123.0, 112.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [150.0, 123.0, 150.0, 165.0, 128.0, 153.0, 156.0, 127.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 161.0, 163.0, 165.0, 162.0, 167.0, 168.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 73.0, 74.0, 83.0, 75.0, 72.0, 153.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 96.0, 95.0, 97.0, 143.0, 98.0, 97.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 146.0, 145.0, 146.0, 151.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 97.0, 96.0, 105.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 69.0, 69.0, 69.0, 72.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 95.0, 87.0, 85.0, 87.0, 87.0, 87.0, 89.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 119.0, 122.0, 125.0, 119.0, 135.0, 127.0, 131.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [139.0, 153.0, 157.0, 151.0, 152.0, 140.0, 152.0, 149.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 68.0, 69.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1524.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.26201760324983], "unit": "score", "name": "Richards", "value": 208.56421600000007}, {"lowerIsBetter": false, "replicates": [190.91256204658268], "unit": "score", "name": "DeltaBlue", "value": 346.3260840000001}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [710.7320540156361], "unit": "score", "name": "Earley", "value": 937.7134409999999}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [25300.0], "unit": "score", "name": "RegExp", "value": 36.007312252964404}, {"lowerIsBetter": false, "replicates": [689.6551724137931], "unit": "score", "name": "Splay", "value": 118.16195000000003}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 20983.38146007729}]} 06:04:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20983.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1524.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6715.46"}}} 06:04:34 INFO - Return code: 0 06:04:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:04:34 INFO - # TBPL SUCCESS # 06:04:34 INFO - Running post-action listener: _resource_record_post_action 06:04:34 INFO - Running post-run listener: _resource_record_post_run 06:04:35 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 32768; Write bytes: 565727232; Read time: 572; Write time: 869772 06:04:35 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 251482112; Read time: 0; Write time: 604584 06:04:35 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 32768; Write bytes: 314245120; Read time: 572; Write time: 265188 06:04:35 INFO - Running post-run listener: _upload_blobber_files 06:04:35 INFO - Blob upload gear active. 06:04:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:04:35 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:04:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:04:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:04:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:36 INFO - (blobuploader) - INFO - Done attempting. 06:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:04:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:37 INFO - (blobuploader) - INFO - Done attempting. 06:04:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:37 INFO - Return code: 0 06:04:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:04:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e0318059090da64185fcecceb3c4730d3e0841606ba3ef3c4de3e8766bd1a17b22ad8c1abae071c249a8b046745694c347ef4197dd464f861e344321d2b30cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f913a33c075be7f1479134eec80c8324aba13c48dc9a0670bdd2b2ae34d8cd347cbcae6ae21dee8512cbc8c42ca70c174b2a0ae1e37ccc98a75c972637c72a80"} 06:04:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:04:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:04:37 INFO - Contents: 06:04:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e0318059090da64185fcecceb3c4730d3e0841606ba3ef3c4de3e8766bd1a17b22ad8c1abae071c249a8b046745694c347ef4197dd464f861e344321d2b30cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f913a33c075be7f1479134eec80c8324aba13c48dc9a0670bdd2b2ae34d8cd347cbcae6ae21dee8512cbc8c42ca70c174b2a0ae1e37ccc98a75c972637c72a80"} 06:04:37 INFO - Copying logs to upload dir... 06:04:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.587357 ========= master_lag: 25.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-01 06:05:03.162489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 06:05:03.166488) ========= 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=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 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/Firefox/sha512/7e0318059090da64185fcecceb3c4730d3e0841606ba3ef3c4de3e8766bd1a17b22ad8c1abae071c249a8b046745694c347ef4197dd464f861e344321d2b30cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f913a33c075be7f1479134eec80c8324aba13c48dc9a0670bdd2b2ae34d8cd347cbcae6ae21dee8512cbc8c42ca70c174b2a0ae1e37ccc98a75c972637c72a80"} build_url:https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009674 build_url: 'https://queue.taskcluster.net/v1/task/NVUR8jvZThyfkIkuaQi5dQ/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/Firefox/sha512/7e0318059090da64185fcecceb3c4730d3e0841606ba3ef3c4de3e8766bd1a17b22ad8c1abae071c249a8b046745694c347ef4197dd464f861e344321d2b30cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f913a33c075be7f1479134eec80c8324aba13c48dc9a0670bdd2b2ae34d8cd347cbcae6ae21dee8512cbc8c42ca70c174b2a0ae1e37ccc98a75c972637c72a80"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 06:05:03.350879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-01-01 06:05:03.351232) ========= 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=a194aa7faa1be204aaca7d660000020b-1451648687.475586-598080887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004721 ========= master_lag: 2.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-01-01 06:05:05.371096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 06:05:05.371503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 06:05:05.528315) ========= ========= Total master_lag: 28.10 =========