builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1452243158.99 results: success (0) buildid: 20160107223006 builduid: 7a18aa57cac947b0bbbfccd3d9bb72a7 revision: d4213241bb796fdfa7a5ad4f1989e97b44474364 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:38.987167) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:38.987804) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:38.988089) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.014361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.014641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.052735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.052975) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.102907) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.103211) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.103545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.103821) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 00:52:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-01-08 00:52:39 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.211543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.211837) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.260854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.261152) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d4213241bb796fdfa7a5ad4f1989e97b44474364 --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 d4213241bb796fdfa7a5ad4f1989e97b44474364 --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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 00:52:39,776 truncating revision to first 12 chars 2016-01-08 00:52:39,776 Setting DEBUG logging. 2016-01-08 00:52:39,776 attempt 1/10 2016-01-08 00:52:39,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d4213241bb79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 00:52:40,031 unpacking tar archive at: mozilla-central-d4213241bb79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.831910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.832175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.839891) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.840139) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 00:52:39.840488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-08 00:52:39.840777) ========= /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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:52:40 INFO - MultiFileLogger online at 20160108 00:52:40 in /builds/slave/test-pgo 00:52:40 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 00:52:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:52:40 INFO - {'append_to_log': False, 00:52:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:52:40 INFO - 'blob_upload_branch': 'Firefox', 00:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:52:40 INFO - 'branch': 'Firefox', 00:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 00:52:40 INFO - 'config_files': ('talos/linux_config.py',), 00:52:40 INFO - 'default_actions': ('clobber', 00:52:40 INFO - 'read-buildbot-config', 00:52:40 INFO - 'download-and-extract', 00:52:40 INFO - 'populate-webroot', 00:52:40 INFO - 'create-virtualenv', 00:52:40 INFO - 'install', 00:52:40 INFO - 'run-tests'), 00:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:52:40 INFO - 'download_minidump_stackwalk': True, 00:52:40 INFO - 'download_symbols': 'ondemand', 00:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 00:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 00:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:52:40 INFO - 'installer_path': 'installer.exe', 00:52:40 INFO - 'log_level': 'info', 00:52:40 INFO - 'log_name': 'talos', 00:52:40 INFO - 'log_to_console': True, 00:52:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:52:40 INFO - 'opt_config_files': (), 00:52:40 INFO - 'pip_index': False, 00:52:40 INFO - 'sps_profile': False, 00:52:40 INFO - 'sps_profile_interval': 0, 00:52:40 INFO - 'suite': 'dromaeojs-e10s', 00:52:40 INFO - 'system_bits': '32', 00:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:52:40 INFO - 'title': 'talos-linux64-ix-011', 00:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:52:40 INFO - 'use_talos_json': True, 00:52:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:52:40 INFO - 'work_dir': 'build'} 00:52:40 INFO - ##### 00:52:40 INFO - ##### Running clobber step. 00:52:40 INFO - ##### 00:52:40 INFO - Running pre-action listener: _resource_record_pre_action 00:52:40 INFO - Running main action method: clobber 00:52:40 INFO - rmtree: /builds/slave/test-pgo/build 00:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:52:40 INFO - Running post-action listener: _resource_record_post_action 00:52:40 INFO - ##### 00:52:40 INFO - ##### Running read-buildbot-config step. 00:52:40 INFO - ##### 00:52:40 INFO - Running pre-action listener: _resource_record_pre_action 00:52:40 INFO - Running main action method: read_buildbot_config 00:52:40 INFO - Using buildbot properties: 00:52:40 INFO - { 00:52:40 INFO - "project": "", 00:52:40 INFO - "product": "firefox", 00:52:40 INFO - "script_repo_revision": "production", 00:52:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:52:40 INFO - "repository": "", 00:52:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 00:52:40 INFO - "buildid": "20160107223006", 00:52:40 INFO - "pgo_build": "True", 00:52:40 INFO - "basedir": "/builds/slave/test-pgo", 00:52:40 INFO - "buildnumber": 69, 00:52:40 INFO - "slavename": "talos-linux64-ix-011", 00:52:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:52:40 INFO - "platform": "ubuntu64_hw", 00:52:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 00:52:40 INFO - "branch": "mozilla-central", 00:52:40 INFO - "repo_path": "mozilla-central", 00:52:40 INFO - "revision": "d4213241bb796fdfa7a5ad4f1989e97b44474364", 00:52:40 INFO - "stage_platform": "linux64-pgo", 00:52:40 INFO - "builduid": "7a18aa57cac947b0bbbfccd3d9bb72a7", 00:52:40 INFO - "slavebuilddir": "test" 00:52:40 INFO - } 00:52:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:52:40 INFO - Running post-action listener: _resource_record_post_action 00:52:40 INFO - ##### 00:52:40 INFO - ##### Running download-and-extract step. 00:52:40 INFO - ##### 00:52:40 INFO - Running pre-action listener: _resource_record_pre_action 00:52:40 INFO - Running main action method: download_and_extract 00:52:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:40 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json 00:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json 00:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:52:43 INFO - Downloaded 1302 bytes. 00:52:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:52:43 INFO - Using the following test package requirements: 00:52:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:52:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:43 INFO - u'jsshell-linux-x86_64.zip'], 00:52:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:52:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:52:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:52:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:52:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:52:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:52: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')]} 00:52:43 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:44 INFO - Downloaded 24019195 bytes. 00:52:44 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 00:52:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:44 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 00:52:45 INFO - Return code: 0 00:52:45 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 00:52: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')]} 00:52:45 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:47 INFO - Downloaded 24019195 bytes. 00:52:47 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 00:52:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:47 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 00:52:48 INFO - Return code: 0 00:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:48 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:51 INFO - Downloaded 11132285 bytes. 00:52:51 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 00:52:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:51 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 00:52:51 INFO - Return code: 0 00:52: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')]} 00:52:51 INFO - https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V-3v1HhrTrSxEorZXCZLIA/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 00:52:55 INFO - Downloaded 55877422 bytes. 00:52:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:55 INFO - mkdir: /builds/slave/test-pgo/properties 00:52:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:52:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:52:55 INFO - Contents: 00:52:55 INFO - build_url:https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:55 INFO - Running post-action listener: _resource_record_post_action 00:52:55 INFO - Running post-action listener: set_extra_try_arguments 00:52:55 INFO - ##### 00:52:55 INFO - ##### Running populate-webroot step. 00:52:55 INFO - ##### 00:52:55 INFO - Running pre-action listener: _resource_record_pre_action 00:52:55 INFO - Running main action method: populate_webroot 00:52:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:52:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:52:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:52:55 INFO - '--tppagecycles', 00:52:55 INFO - '7'], 00:52:55 INFO - 'tests': ['tsvgm']}}, 00:52:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:52:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:52:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'tests': ['damp', 'tps']}, 00:52:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['damp', 'tps']}, 00:52:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:52:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:52:55 INFO - 'other': {'tests': ['a11yr', 00:52:55 INFO - 'ts_paint', 00:52:55 INFO - 'tpaint', 00:52:55 INFO - 'sessionrestore', 00:52:55 INFO - 'sessionrestore_no_auto_restore']}, 00:52:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['a11yr', 00:52:55 INFO - 'ts_paint', 00:52:55 INFO - 'tpaint', 00:52:55 INFO - 'sessionrestore', 00:52:55 INFO - 'sessionrestore_no_auto_restore']}, 00:52:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['a11yr', 00:52:55 INFO - 'ts_paint', 00:52:55 INFO - 'tpaint', 00:52:55 INFO - 'sessionrestore', 00:52:55 INFO - 'sessionrestore_no_auto_restore']}, 00:52:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['a11yr', 00:52:55 INFO - 'ts_paint', 00:52:55 INFO - 'tpaint', 00:52:55 INFO - 'sessionrestore', 00:52:55 INFO - 'sessionrestore_no_auto_restore']}, 00:52:55 INFO - 'other_l64': {'tests': ['a11yr', 00:52:55 INFO - 'ts_paint', 00:52:55 INFO - 'tpaint', 00:52:55 INFO - 'sessionrestore', 00:52:55 INFO - 'sessionrestore_no_auto_restore']}, 00:52:55 INFO - 'other_nol64': {'tests': ['a11yr', 00:52:55 INFO - 'ts_paint', 00:52:55 INFO - 'tpaint', 00:52:55 INFO - 'sessionrestore', 00:52:55 INFO - 'sessionrestore_no_auto_restore']}, 00:52:55 INFO - 'svgr': {'tests': ['tsvgx', 00:52:55 INFO - 'tsvgr_opacity', 00:52:55 INFO - 'tart', 00:52:55 INFO - 'tscrollx', 00:52:55 INFO - 'cart']}, 00:52:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['tsvgx', 00:52:55 INFO - 'tsvgr_opacity', 00:52:55 INFO - 'tart', 00:52:55 INFO - 'tscrollx', 00:52:55 INFO - 'cart']}, 00:52:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'tests': ['tp5o']}, 00:52:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'talos_options': ['--e10s'], 00:52:55 INFO - 'tests': ['tp5o']}, 00:52:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'talos_options': ['--xperf_path', 00:52:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:55 INFO - 'tests': ['tp5n']}, 00:52:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:55 INFO - 'talos_options': ['--e10s', 00:52:55 INFO - '--xperf_path', 00:52:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:55 INFO - 'tests': ['tp5n']}}, 00:52:55 INFO - 'talos.zip': {'path': '', 00:52:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:52:55 INFO - Running post-action listener: _resource_record_post_action 00:52:55 INFO - ##### 00:52:55 INFO - ##### Running create-virtualenv step. 00:52:55 INFO - ##### 00:52:55 INFO - Running pre-action listener: _resource_record_pre_action 00:52:55 INFO - Running main action method: create_virtualenv 00:52:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:52:55 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 00:52:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:52:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:52:55 INFO - Using real prefix '/usr' 00:52:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:52:55 INFO - Installing distribute.............................................................................................................................................................................................done. 00:52:57 INFO - Installing pip.................done. 00:52:57 INFO - Return code: 0 00:52:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:52:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:52:57 INFO - Using env: {'DISPLAY': ':0', 00:52:57 INFO - 'HOME': '/home/cltbld', 00:52:57 INFO - 'LANG': 'en_US.UTF-8', 00:52:57 INFO - 'LANGUAGE': 'en_US:en', 00:52:57 INFO - 'LOGNAME': 'cltbld', 00:52:57 INFO - 'MAIL': '/var/mail/cltbld', 00:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:57 INFO - 'MOZ_NO_REMOTE': '1', 00:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:57 INFO - 'NO_EM_RESTART': '1', 00:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 00:52:57 INFO - 'SHELL': '/bin/bash', 00:52:57 INFO - 'SHLVL': '1', 00:52:57 INFO - 'TERM': 'linux', 00:52:57 INFO - 'TMOUT': '86400', 00:52:57 INFO - 'USER': 'cltbld', 00:52:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:57 INFO - '_': '/tools/buildbot/bin/python'} 00:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:58 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 00:52:58 INFO - Cleaning up... 00:52:58 INFO - Return code: 0 00:52:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:52: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')]} 00:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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', '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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:52: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:52: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 psutil>=0.7.1 00:52:58 INFO - Using env: {'DISPLAY': ':0', 00:52:58 INFO - 'HOME': '/home/cltbld', 00:52:58 INFO - 'LANG': 'en_US.UTF-8', 00:52:58 INFO - 'LANGUAGE': 'en_US:en', 00:52:58 INFO - 'LOGNAME': 'cltbld', 00:52:58 INFO - 'MAIL': '/var/mail/cltbld', 00:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:58 INFO - 'MOZ_NO_REMOTE': '1', 00:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:58 INFO - 'NO_EM_RESTART': '1', 00:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 00:52:58 INFO - 'SHELL': '/bin/bash', 00:52:58 INFO - 'SHLVL': '1', 00:52:58 INFO - 'TERM': 'linux', 00:52:58 INFO - 'TMOUT': '86400', 00:52:58 INFO - 'USER': 'cltbld', 00:52:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:58 INFO - '_': '/tools/buildbot/bin/python'} 00:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:58 INFO - Downloading/unpacking psutil>=0.7.1 00:52: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 00:52: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 00:52: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 00:52: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 00:52: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 00:52: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 00:52:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:52:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:53:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:00 INFO - Installing collected packages: psutil 00:53:00 INFO - Running setup.py install for psutil 00:53:00 INFO - building 'psutil._psutil_linux' extension 00:53:00 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 00:53:00 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 00:53:00 INFO - building 'psutil._psutil_posix' extension 00:53:00 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 00:53:00 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 00:53:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:00 INFO - Successfully installed psutil 00:53:00 INFO - Cleaning up... 00:53:00 INFO - Return code: 0 00:53:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:53: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')]} 00:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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')]} 00:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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', '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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:53: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 00:53: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 mozsystemmonitor==0.0.0 00:53:00 INFO - Using env: {'DISPLAY': ':0', 00:53:00 INFO - 'HOME': '/home/cltbld', 00:53:00 INFO - 'LANG': 'en_US.UTF-8', 00:53:00 INFO - 'LANGUAGE': 'en_US:en', 00:53:00 INFO - 'LOGNAME': 'cltbld', 00:53:00 INFO - 'MAIL': '/var/mail/cltbld', 00:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:00 INFO - 'MOZ_NO_REMOTE': '1', 00:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:00 INFO - 'NO_EM_RESTART': '1', 00:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:00 INFO - 'SHELL': '/bin/bash', 00:53:00 INFO - 'SHLVL': '1', 00:53:00 INFO - 'TERM': 'linux', 00:53:00 INFO - 'TMOUT': '86400', 00:53:00 INFO - 'USER': 'cltbld', 00:53:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:00 INFO - '_': '/tools/buildbot/bin/python'} 00:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:53:02 INFO - Installing collected packages: mozsystemmonitor 00:53:02 INFO - Running setup.py install for mozsystemmonitor 00:53:02 INFO - Successfully installed mozsystemmonitor 00:53:02 INFO - Cleaning up... 00:53:02 INFO - Return code: 0 00:53:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:53:02 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')]} 00:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:02 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')]} 00:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:02 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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:53:02 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 00:53:02 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 00:53:02 INFO - Using env: {'DISPLAY': ':0', 00:53:02 INFO - 'HOME': '/home/cltbld', 00:53:02 INFO - 'LANG': 'en_US.UTF-8', 00:53:02 INFO - 'LANGUAGE': 'en_US:en', 00:53:02 INFO - 'LOGNAME': 'cltbld', 00:53:02 INFO - 'MAIL': '/var/mail/cltbld', 00:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:02 INFO - 'MOZ_NO_REMOTE': '1', 00:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:02 INFO - 'NO_EM_RESTART': '1', 00:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:02 INFO - 'SHELL': '/bin/bash', 00:53:02 INFO - 'SHLVL': '1', 00:53:02 INFO - 'TERM': 'linux', 00:53:02 INFO - 'TMOUT': '86400', 00:53:02 INFO - 'USER': 'cltbld', 00:53:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:02 INFO - '_': '/tools/buildbot/bin/python'} 00:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:02 INFO - Downloading/unpacking blobuploader==1.2.4 00:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:04 INFO - Downloading blobuploader-1.2.4.tar.gz 00:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:53:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:53:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:05 INFO - Downloading docopt-0.6.1.tar.gz 00:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:53:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:53:05 INFO - Installing collected packages: blobuploader, requests, docopt 00:53:05 INFO - Running setup.py install for blobuploader 00:53:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:53:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:53:05 INFO - Running setup.py install for requests 00:53:05 INFO - Running setup.py install for docopt 00:53:05 INFO - Successfully installed blobuploader requests docopt 00:53:05 INFO - Cleaning up... 00:53:05 INFO - Return code: 0 00:53:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:05 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')]} 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 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')]} 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:53:05 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 00:53:05 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 00:53:05 INFO - Using env: {'DISPLAY': ':0', 00:53:05 INFO - 'HOME': '/home/cltbld', 00:53:05 INFO - 'LANG': 'en_US.UTF-8', 00:53:05 INFO - 'LANGUAGE': 'en_US:en', 00:53:05 INFO - 'LOGNAME': 'cltbld', 00:53:05 INFO - 'MAIL': '/var/mail/cltbld', 00:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:05 INFO - 'MOZ_NO_REMOTE': '1', 00:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:05 INFO - 'NO_EM_RESTART': '1', 00:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:06 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:06 INFO - 'SHELL': '/bin/bash', 00:53:06 INFO - 'SHLVL': '1', 00:53:06 INFO - 'TERM': 'linux', 00:53:06 INFO - 'TMOUT': '86400', 00:53:06 INFO - 'USER': 'cltbld', 00:53:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:06 INFO - '_': '/tools/buildbot/bin/python'} 00:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:06 INFO - Running setup.py (path:/tmp/pip-5ASflW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:06 INFO - Running setup.py (path:/tmp/pip-1MyVuj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:06 INFO - Running setup.py (path:/tmp/pip-O32eDo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:06 INFO - Running setup.py (path:/tmp/pip-H5Lclm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:06 INFO - Running setup.py (path:/tmp/pip-o9qygd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:06 INFO - Running setup.py (path:/tmp/pip-sUrzxJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:06 INFO - Running setup.py (path:/tmp/pip-BxVgU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:06 INFO - Running setup.py (path:/tmp/pip-0hS0fK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:06 INFO - Running setup.py (path:/tmp/pip-984Q_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:06 INFO - Running setup.py (path:/tmp/pip-APaP6l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:06 INFO - Running setup.py (path:/tmp/pip-gH76NY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:06 INFO - Running setup.py (path:/tmp/pip-6TJxel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:07 INFO - Running setup.py (path:/tmp/pip-dSr0Bo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:07 INFO - Running setup.py (path:/tmp/pip-fuAO_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:07 INFO - Running setup.py (path:/tmp/pip-_hO1MR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:07 INFO - Running setup.py (path:/tmp/pip-kTQZvi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:07 INFO - Running setup.py (path:/tmp/pip-_Wv7xh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:53:07 INFO - Running setup.py install for manifestparser 00:53:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:53:07 INFO - Running setup.py install for mozcrash 00:53:07 INFO - Running setup.py install for mozdebug 00:53:07 INFO - Running setup.py install for mozdevice 00:53:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:53:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:53:07 INFO - Running setup.py install for mozfile 00:53:07 INFO - Running setup.py install for mozhttpd 00:53:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Running setup.py install for mozinfo 00:53:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Running setup.py install for mozInstall 00:53:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Running setup.py install for mozleak 00:53:08 INFO - Running setup.py install for mozlog 00:53:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Running setup.py install for moznetwork 00:53:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Running setup.py install for mozprocess 00:53:08 INFO - Running setup.py install for mozprofile 00:53:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Running setup.py install for mozrunner 00:53:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:53:08 INFO - Running setup.py install for mozscreenshot 00:53:08 INFO - Running setup.py install for moztest 00:53:09 INFO - Running setup.py install for mozversion 00:53:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:53:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:53:09 INFO - Cleaning up... 00:53:09 INFO - Return code: 0 00:53:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:09 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')]} 00:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:09 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')]} 00:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:09 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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:53:09 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 00:53:09 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 00:53:09 INFO - Using env: {'DISPLAY': ':0', 00:53:09 INFO - 'HOME': '/home/cltbld', 00:53:09 INFO - 'LANG': 'en_US.UTF-8', 00:53:09 INFO - 'LANGUAGE': 'en_US:en', 00:53:09 INFO - 'LOGNAME': 'cltbld', 00:53:09 INFO - 'MAIL': '/var/mail/cltbld', 00:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:09 INFO - 'MOZ_NO_REMOTE': '1', 00:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:09 INFO - 'NO_EM_RESTART': '1', 00:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:09 INFO - 'SHELL': '/bin/bash', 00:53:09 INFO - 'SHLVL': '1', 00:53:09 INFO - 'TERM': 'linux', 00:53:09 INFO - 'TMOUT': '86400', 00:53:09 INFO - 'USER': 'cltbld', 00:53:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:09 INFO - '_': '/tools/buildbot/bin/python'} 00:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:09 INFO - Running setup.py (path:/tmp/pip-e8FinF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:09 INFO - Running setup.py (path:/tmp/pip-7glfwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:09 INFO - Running setup.py (path:/tmp/pip-AKNIK9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:09 INFO - Running setup.py (path:/tmp/pip-K1s3mJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:09 INFO - Running setup.py (path:/tmp/pip-nh3qcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:09 INFO - Running setup.py (path:/tmp/pip-UU3Ru8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:09 INFO - Running setup.py (path:/tmp/pip-gZeIXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:53:09 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)) 00:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:09 INFO - Running setup.py (path:/tmp/pip-77jMs_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:10 INFO - Running setup.py (path:/tmp/pip-zwNmuw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:10 INFO - Running setup.py (path:/tmp/pip-UCXTbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:10 INFO - Running setup.py (path:/tmp/pip-mUFTP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:10 INFO - Running setup.py (path:/tmp/pip-QvHGjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:10 INFO - Running setup.py (path:/tmp/pip-L4_CuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:10 INFO - Running setup.py (path:/tmp/pip-Ce71Bi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:10 INFO - Running setup.py (path:/tmp/pip-CKbIdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:10 INFO - Running setup.py (path:/tmp/pip-mlKKqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:53:10 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)) 00:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:10 INFO - Running setup.py (path:/tmp/pip-cgJ9aS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:53:10 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)) 00:53:10 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)) 00:53:10 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)) 00:53:10 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)) 00:53:10 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)) 00:53:10 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)) 00:53:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:12 INFO - Downloading blessings-1.5.1.tar.gz 00:53:12 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 00:53:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:53:12 INFO - Installing collected packages: blessings 00:53:12 INFO - Running setup.py install for blessings 00:53:12 INFO - Successfully installed blessings 00:53:12 INFO - Cleaning up... 00:53:12 INFO - Return code: 0 00:53:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:53:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:12 INFO - Reading from file tmpfile_stdout 00:53:12 INFO - Current package versions: 00:53:12 INFO - argparse == 1.2.1 00:53:12 INFO - blessings == 1.5.1 00:53:12 INFO - blobuploader == 1.2.4 00:53:12 INFO - docopt == 0.6.1 00:53:12 INFO - manifestparser == 1.1 00:53:12 INFO - mozInstall == 1.12 00:53:12 INFO - mozcrash == 0.16 00:53:12 INFO - mozdebug == 0.1 00:53:12 INFO - mozdevice == 0.47 00:53:12 INFO - mozfile == 1.2 00:53:12 INFO - mozhttpd == 0.7 00:53:12 INFO - mozinfo == 0.9 00:53:12 INFO - mozleak == 0.1 00:53:12 INFO - mozlog == 3.1 00:53:12 INFO - moznetwork == 0.27 00:53:12 INFO - mozprocess == 0.22 00:53:12 INFO - mozprofile == 0.28 00:53:12 INFO - mozrunner == 6.11 00:53:12 INFO - mozscreenshot == 0.1 00:53:12 INFO - mozsystemmonitor == 0.0 00:53:12 INFO - moztest == 0.7 00:53:12 INFO - mozversion == 1.4 00:53:12 INFO - psutil == 3.1.1 00:53:12 INFO - requests == 1.2.3 00:53:12 INFO - wsgiref == 0.1.2 00:53:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:53:12 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')]} 00:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:12 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')]} 00:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:12 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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:53:12 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 00:53:12 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 00:53:12 INFO - Using env: {'DISPLAY': ':0', 00:53:12 INFO - 'HOME': '/home/cltbld', 00:53:12 INFO - 'LANG': 'en_US.UTF-8', 00:53:12 INFO - 'LANGUAGE': 'en_US:en', 00:53:12 INFO - 'LOGNAME': 'cltbld', 00:53:12 INFO - 'MAIL': '/var/mail/cltbld', 00:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:12 INFO - 'MOZ_NO_REMOTE': '1', 00:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:12 INFO - 'NO_EM_RESTART': '1', 00:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:12 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:12 INFO - 'SHELL': '/bin/bash', 00:53:12 INFO - 'SHLVL': '1', 00:53:12 INFO - 'TERM': 'linux', 00:53:12 INFO - 'TMOUT': '86400', 00:53:12 INFO - 'USER': 'cltbld', 00:53:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:12 INFO - '_': '/tools/buildbot/bin/python'} 00:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 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)) 00:53:13 INFO - Cleaning up... 00:53:13 INFO - Return code: 0 00:53:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:13 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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:53:13 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 00:53:13 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 00:53:13 INFO - Using env: {'DISPLAY': ':0', 00:53:13 INFO - 'HOME': '/home/cltbld', 00:53:13 INFO - 'LANG': 'en_US.UTF-8', 00:53:13 INFO - 'LANGUAGE': 'en_US:en', 00:53:13 INFO - 'LOGNAME': 'cltbld', 00:53:13 INFO - 'MAIL': '/var/mail/cltbld', 00:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:13 INFO - 'MOZ_NO_REMOTE': '1', 00:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:13 INFO - 'NO_EM_RESTART': '1', 00:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:13 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:13 INFO - 'SHELL': '/bin/bash', 00:53:13 INFO - 'SHLVL': '1', 00:53:13 INFO - 'TERM': 'linux', 00:53:13 INFO - 'TMOUT': '86400', 00:53:13 INFO - 'USER': 'cltbld', 00:53:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:13 INFO - '_': '/tools/buildbot/bin/python'} 00:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:13 INFO - Downloading/unpacking jsonschema 00:53:13 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 00:53:13 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 00:53:13 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 00:53:13 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 00:53:13 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 00:53:13 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 00:53:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:53:14 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 00:53:14 INFO - Downloading/unpacking functools32 (from jsonschema) 00:53:14 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 00:53:14 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 00:53:14 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 00:53:14 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 00:53:14 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 00:53:14 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 00:53:15 INFO - Downloading functools32-3.2.3-2.tar.gz 00:53:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:53:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:53:15 INFO - warning: no files found matching '*.txt' 00:53:15 INFO - no previously-included directories found matching 'build' 00:53:15 INFO - no previously-included directories found matching 'dist' 00:53:15 INFO - no previously-included directories found matching '.git*' 00:53:15 INFO - Installing collected packages: jsonschema, functools32 00:53:15 INFO - Running setup.py install for functools32 00:53:15 INFO - warning: no files found matching '*.txt' 00:53:15 INFO - no previously-included directories found matching 'build' 00:53:15 INFO - no previously-included directories found matching 'dist' 00:53:15 INFO - no previously-included directories found matching '.git*' 00:53:15 INFO - Successfully installed jsonschema functools32 00:53:15 INFO - Cleaning up... 00:53:15 INFO - Return code: 0 00:53:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:53:15 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')]} 00:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:15 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')]} 00:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:15 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 0x7f440b3abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', '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 00:53:15 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 00:53:15 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 00:53:15 INFO - Using env: {'DISPLAY': ':0', 00:53:15 INFO - 'HOME': '/home/cltbld', 00:53:15 INFO - 'LANG': 'en_US.UTF-8', 00:53:15 INFO - 'LANGUAGE': 'en_US:en', 00:53:15 INFO - 'LOGNAME': 'cltbld', 00:53:15 INFO - 'MAIL': '/var/mail/cltbld', 00:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:15 INFO - 'MOZ_NO_REMOTE': '1', 00:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:15 INFO - 'NO_EM_RESTART': '1', 00:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:15 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:15 INFO - 'SHELL': '/bin/bash', 00:53:15 INFO - 'SHLVL': '1', 00:53:15 INFO - 'TERM': 'linux', 00:53:15 INFO - 'TMOUT': '86400', 00:53:15 INFO - 'USER': 'cltbld', 00:53:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:15 INFO - '_': '/tools/buildbot/bin/python'} 00:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:15 INFO - Downloading/unpacking flake8 00:53:15 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 00:53:15 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 00:53:15 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 00:53:15 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 00:53:15 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 00:53:15 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 00:53:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:53:17 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 00:53:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:53:17 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 00:53:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 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 00:53:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:53:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:53:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:53:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:53:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:53:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:53:18 INFO - no previously-included directories found matching 'docs/_build' 00:53:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:53:18 INFO - Running setup.py install for pep8 00:53:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:53:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:53:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:53:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:53:18 INFO - no previously-included directories found matching 'docs/_build' 00:53:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:53:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:53:18 INFO - Cleaning up... 00:53:18 INFO - Return code: 0 00:53:18 INFO - Running post-action listener: _resource_record_post_action 00:53:18 INFO - Running post-action listener: _start_resource_monitoring 00:53:18 INFO - Starting resource monitoring. 00:53:18 INFO - ##### 00:53:18 INFO - ##### Running install step. 00:53:18 INFO - ##### 00:53:18 INFO - Running pre-action listener: _resource_record_pre_action 00:53:18 INFO - Running main action method: install 00:53:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:53:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:53:18 INFO - Reading from file tmpfile_stdout 00:53:18 INFO - Detecting whether we're running mozinstall >=1.0... 00:53:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:53:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:53:18 INFO - Reading from file tmpfile_stdout 00:53:18 INFO - Output received: 00:53:18 INFO - Usage: mozinstall [options] installer 00:53:18 INFO - Options: 00:53:18 INFO - -h, --help show this help message and exit 00:53:18 INFO - -d DEST, --destination=DEST 00:53:18 INFO - Directory to install application into. [default: 00:53:18 INFO - "/builds/slave/test-pgo"] 00:53:18 INFO - --app=APP Application being installed. [default: firefox] 00:53:18 INFO - mkdir: /builds/slave/test-pgo/build/application 00:53:18 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'] 00:53:18 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 00:53:34 INFO - Reading from file tmpfile_stdout 00:53:34 INFO - Output received: 00:53:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:53:34 INFO - Running post-action listener: _resource_record_post_action 00:53:34 INFO - ##### 00:53:34 INFO - ##### Running run-tests step. 00:53:34 INFO - ##### 00:53:34 INFO - Running pre-action listener: _resource_record_pre_action 00:53:34 INFO - Running main action method: run_tests 00:53:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:53:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:53:34 INFO - Python 2.7.3 00:53:34 INFO - Return code: 0 00:53:34 INFO - grabbing minidump binary from tooltool 00:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:34 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 0x2b2c540>, '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 0x2b2d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:53:34 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 00:53:34 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 00:53:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:34 INFO - Return code: 0 00:53:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:53:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:53:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:53:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:53:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:53:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:53:35 INFO - Return code: 0 00:53:35 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/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 00:53:35 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/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 00:53:35 INFO - Using env: {'DISPLAY': ':0', 00:53:35 INFO - 'HOME': '/home/cltbld', 00:53:35 INFO - 'LANG': 'en_US.UTF-8', 00:53:35 INFO - 'LANGUAGE': 'en_US:en', 00:53:35 INFO - 'LOGNAME': 'cltbld', 00:53:35 INFO - 'MAIL': '/var/mail/cltbld', 00:53:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:35 INFO - 'MOZ_NO_REMOTE': '1', 00:53:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:35 INFO - 'NO_EM_RESTART': '1', 00:53:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:53:35 INFO - 'PWD': '/builds/slave/test-pgo', 00:53:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:53:35 INFO - 'SHELL': '/bin/bash', 00:53:35 INFO - 'SHLVL': '1', 00:53:35 INFO - 'TERM': 'linux', 00:53:35 INFO - 'TMOUT': '86400', 00:53:35 INFO - 'USER': 'cltbld', 00:53:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476', 00:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:35 INFO - '_': '/tools/buildbot/bin/python'} 00:53:35 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/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 00:53:35 INFO - mozversion application_buildid: 20160107223006 00:53:35 INFO - mozversion application_changeset: d4213241bb796fdfa7a5ad4f1989e97b44474364 00:53:35 INFO - mozversion application_display_name: Nightly 00:53:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:35 INFO - mozversion application_name: Firefox 00:53:35 INFO - mozversion application_remotingname: firefox 00:53:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:53:35 INFO - mozversion application_vendor: Mozilla 00:53:35 INFO - mozversion application_version: 46.0a1 00:53:35 INFO - mozversion platform_buildid: 20160107223006 00:53:35 INFO - mozversion platform_changeset: d4213241bb796fdfa7a5ad4f1989e97b44474364 00:53:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:53:35 INFO - mozversion platform_version: 46.0a1 00:53:35 INFO - using testdate: 1452243215 00:53:35 INFO - actual date: 1452243215 00:53:35 INFO - starting webserver on 'localhost:36803' 00:53:35 INFO - SUITE-START | Running 3 tests 00:53:35 INFO - TEST-START | dromaeo_css 00:53:35 INFO - operating with platform_type : linux_ 00:53:35 INFO - Initialising browser for dromaeo_css test... 00:53:35 INFO - TEST-INFO | started process 4988 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt1vtt_/profile http://localhost:36803/getInfo.html) 00:53:40 INFO - PROCESS | 4988 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 00:53:41 INFO - PROCESS | 4988 | __metrics Screen width/height:1600/1200 00:53:41 INFO - PROCESS | 4988 | colorDepth:24 00:53:41 INFO - PROCESS | 4988 | Browser inner width/height: 1024/697 00:53:41 INFO - PROCESS | 4988 | __metrics 00:53:41 INFO - PROCESS | 4988 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:53:41 INFO - PROCESS | 4988 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 00:53:42 INFO - TEST-INFO | 4988: exit 0 00:53:42 INFO - Browser initialized. 00:53:42 INFO - Running cycle 1/1 for dromaeo_css test... 00:53:42 INFO - TEST-INFO | started process 5118 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt1vtt_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:53:54 INFO - PROCESS | 5118 | RSS: Main: 150769664 00:53:54 INFO - PROCESS | 5118 | 00:54:43 INFO - PROCESS | 5118 | 1452243283732 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] 00:56:52 INFO - PROCESS | 5118 | Cycle 1(1): loaded http://localhost:36803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36803/tests/dromaeo/cssquery-ext.html) 00:56:53 INFO - PROCESS | 5118 | RSS: Main: 157786112 00:56:53 INFO - PROCESS | 5118 | 00:59:55 INFO - PROCESS | 5118 | Cycle 1(1): loaded http://localhost:36803/tests/dromaeo/cssquery-ext.html (next: http://localhost:36803/tests/dromaeo/cssquery-jquery.html) 00:59:55 INFO - PROCESS | 5118 | RSS: Main: 153387008 00:59:55 INFO - PROCESS | 5118 | 01:02:57 INFO - PROCESS | 5118 | Cycle 1(1): loaded http://localhost:36803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36803/tests/dromaeo/cssquery-mootools.html) 01:02:58 INFO - PROCESS | 5118 | RSS: Main: 153722880 01:02:58 INFO - PROCESS | 5118 | 01:05:59 INFO - PROCESS | 5118 | Cycle 1(1): loaded http://localhost:36803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36803/tests/dromaeo/cssquery-prototype.html) 01:06:00 INFO - PROCESS | 5118 | RSS: Main: 152829952 01:06:00 INFO - PROCESS | 5118 | 01:09:02 INFO - PROCESS | 5118 | Cycle 1(1): loaded http://localhost:36803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36803/tests/dromaeo/cssquery-yui.html) 01:09:03 INFO - PROCESS | 5118 | RSS: Main: 153358336 01:09:03 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | Cycle 1(1): loaded http://localhost:36803/tests/dromaeo/cssquery-yui.html (next: http://localhost:36803/tests/dromaeo/cssquery-dojo.html) 01:12:06 INFO - PROCESS | 5118 | RSS: Main: 155865088 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | __start_tp_report 01:12:06 INFO - PROCESS | 5118 | _x_x_mozilla_page_load 01:12:06 INFO - PROCESS | 5118 | _x_x_mozilla_page_load_details 01:12:06 INFO - PROCESS | 5118 | |i|pagename|runs| 01:12:06 INFO - PROCESS | 5118 | |0;dojo.html;3087.1201707513355;3132.2482604175007;3137.215696075981;3169.825659588722;3175.555422240887;5105.540501354877;5137.203733421321;5163.664361816479;5241.1876159195335;5246.291750613666;5201.349831271091;5207.505286997739;5252.71110088945;5260.552853007499;5309.601779866506;4498.730076195422;4772.260299653551;4971.428285747149;4987.1521841286885;4990.401151861782;4766.499517550659;4909.214525675892;4951.603871690274;4968.527989840977;4968.577670897978;4763.61891048717;4770.880727981794;4837.371141751585;4864.027194561102;4878.804847806084;4818.951810481885;4822.517748225149;4843.66094373394;4866.051120031595;4890.95109048912;4664.603508701731;4803.231482962709;4822;4825.324454576362;4855.708657480563;5070.264811602334;5117.385913690381;5141.434442211354;5146.536811686929;5159;5580.720963951827;5604.859878503029;5634.802781902655;5638.40796716343;5654.6324488908085;5498.862528436821;5618.213450116987;5637.295338082739;5681.914771278434;5697.544196464273;5235.240890070919;5272.130098533776;5277.86805329866;5293.100172970604;5307.787688492494;5733.569982251348;5753.85615359611;5766.135079738073;5773.6824474654295;5779.884402312015;5451.809186678447;5547.805826796042;5564.860878478071;5567.916481252784;5602.971985140048;5730.971345143247;5732.971335143381;5733.971330143323;5740.971295143581;5748.281464816898;5649.209110724501;5666.291713535808;5695.800646977336;5697.202391665171;5708.286464191976;5385.461453854661;5536.861578460571;5615.803446879339;5653.547716182696;5702.543796496353;4312.568743125662;4317.84887528935;4319.136172765459;4325.826966921288;4350.129974005212;3824.904377390532;3848.1534062506203;3884.592117827644;3894.337962546374;3901.3757798752063;5107.080725469451;5233.633645644768;5265.736713164327;5284.101702710548;5364.7317634118135;5653.4629210225785;5660.433956604306;5666.688332141772;5670.603057785916;5687.203791469197;5106;5273.762680679379;5278.234655974862;5280.049591073567;5335.973320133375;4762.976185119052;4825;4868.634852386085;4890.682105663121;4903.436104847917;5842.532597392198;5854.531637468992;5857.355690874;5860.501857342088;5868.765249390062;5559.193916881949;5660.858478537904;5662.03745363281;5662.5469962402085;5663.9716801415725;5767.307923049261;5804.24544809189;5906.675132867734;5907.527397808251;5937.109433584997;5577.27495425592;5581.246531718166;5587.804426845041;5602.85992850182;5612.354579223442;5442.455754424526;5583.944160558505;5596.636218645938;5651.350094739158;5661.46216109469;5532.889342213052;5600.103983362643;5600.775968961359;5604.019296622993;5630.324361076697;5532.391436942014;5606;5607.299087614048;5627.127795191752;5635.9436405635415;5267.367915850123;5367.221752845738;5483.8080667176455;5498.890022199614;5530.281063461724;5576.358718747396;5605.831825045255;5611.074172761449;5612.8877422450505;5625.831225063254;5450.2369668247275;5464;5464.453554644504;5478.205660179331;5488.067028605067 01:12:06 INFO - PROCESS | 5118 | |1;ext.html;509.3607522559188;539.3393093460511;544.3821262866645;561.5647872898503;569.7066011004331;26948.461030779374;34987;35123.82438087806;35250.64749352502;35308.47037294439;37308.253834923285;37391.62608373915;37466.4380034299;37569.24861502768;37840.24319513608;8240.752777416672;8388.119247479019;8435.662573497053;8441.620127094266;8449.95775021124;8173.223543763363;8300.543470109142;8301.750947471555;8312.376571757111;8343.45767525109;8352.373571982125;8370.707025254118;8396.83206335873;8437.367197460184;8438.451500652469;8262.215089566482;8360.163983601622;8369.665213391487;8602.31181505478;8611.95694021526;8395.118512556215;8588.269997050258;8608.268297194745;8610.052894181636;8625.482471051695;38793.22413551741;39002.60997390018;39104.21791564181;39107.41338879919;39160;3001.0846691759007;3013.186439661301;3191;3486.703630191437;3488.988193423904;29344.413111737646;29644.851775741197;29878.253043673863;29935.550966735518;29997.850010750026;3442.896713098611;3510.859565617372;3566.1262990567216;3623.832483402769;3681.0613293610227;191743;192787;193769;194133;194186.02906985517;50301.74849125731;51434.97130057378;55514.44485555174;55692.32923012316;55718.72140639271;65018;65575.34424655788;66010.33989660042;66053.33946660568;66107.33892661108;13798.586042418743;13930.815880650056;13933.233672147926;13970.580882573538;13976.091554048955;11165.385903775208;11208.27146235492;11220.270682405617;11236.157288203418;11277.492512836778;18565;18663.72004419935;18672.253109875724;18772.81227187738;18867.150978206013;7439.665215065335;7634.6946122154495;7635.885461718079;7707.535568242016;7711.537307761552;959.8080383923243;986.28001558861;998.5556427389741;1007.5466040281756;1062.2617280989639;27915.441691166063;28200.71799282022;28383;28413;28495.715042849723;1052.7947050325267;1117.6088369070924;1138.0269869261663;1155.8035134027236;1183.2663748476;14467.855321446861;14621.19583422922;14628.780568291484;14665.266736663125;14717.264136793117;299839;301594;302702;303973;305907;49925.25112123321;50037.74981125071;50044.74977625089;50206.24690629644;50384.496155038716;1305.3147097773556;1311.0560396514495;1312.3700623700486;1322.3983087695076;1323.8080478330587;27344;28265.57601635936;28276.396351368236;28292.292692682026;28612.57081143826;44367.77816110899;44459;44721.32918006167;44981;45010.77494612506;299689;300431;301591;301765;302110;30096.548551771302;30792.384152317278;30914;31002.534961975136;31270.374592508477;35795.284094318486;36305.45541816928;36521.452178216816;36998.44502332414;37024.07439814026;31159;31363.215919602193;31381.8430907844;31567.36865262728;32962.5055624161;34014.149646259044;34697.306053878274;35022.64977350194;35166.472502911965;35247.471287931214;33883.781040801085;33908.830455847565;34541.61833526631;34736;34887;27414;30837.99553029046;31249.531257030707;31432.685673142976;31586.842065789522;23624.763752362258;23840.165594204118;24513.142040028513;24670.862628717485;26398.86800565985 01:12:06 INFO - PROCESS | 5118 | |2;jquery.html;349.1271820448877;350.6388419927476;351.15722266560255;351.33246831021074;353.16476532999434;16547.172641367943;16802.495925122235;16825.242864071115;17598.20808063637;17914.014729189905;10938;11032.28290161139;11072.501737421815;12262.509499620026;16477.83522164778;4893.755312234392;5090.0328937501945;5136.691798492084;5447;5454;5343.744220108271;5449.83650490484;5474.315710536183;5492.176173573976;5515.944840551583;4390.978045109786;5039;5043.218301163325;5166.483351664841;5355.544778693816;5204.791808327663;5214.296070030536;5240.921386179191;5244.213367994793;5717.828465146011;5453.481919217668;5460.836174914759;5469.425710300401;5473.452654734495;5520.779168833242;12077.758444831143;12430.75138497234;18332.90833545837;19852.404427867186;19853.50366240841;2004.7894971028124;2023.5143565544163;2030.4923769057737;2047.7952204779551;2100.527381339202;9378.53107344637;9740.415575065519;11493.885061149365;12353;12942.935285323512;1815.9364422245158;1817.3820900893759;1853.5922097138607;1871.897045662488;1925.1144473542188;54363.424491111655;56115.71942140304;57181;57259.42740572582;57702.13446798259;10014.599416023424;10050.59797608102;10054.74863128413;10079.496025198858;10151;12875.969922406184;13102.934485327512;13133.474661013644;13179.07746457758;13219.801702974462;7257.782266532013;7361.30067643573;7397.37122344596;7422.109346878409;7545.396368290523;6865.176178858569;7156.785296441115;7177.4258059355125;7206.243344448862;7219.8917016244795;4282.721623094489;4410.4927933287445;4428.22506061438;4443;4483.730976141442;1714.9485515434558;1807.4396936949588;1828.9268429262681;1836.6785812482763;1869.5326168457887;817.5993763056059;928.8467402878584;929.8930622978444;938.5119737736339;1045.6758404894356;15058.397664093533;15648.92175539115;15691.215439227994;15764.605884852741;16431.838793927946;943.118184497497;951.1772316945792;961.6730311693917;984.4093543873762;990.2276224544867;9315.813683726288;9594.1365277124;9667.854982175273;9679.854802177973;9796.412215267106;381310;387867;389197;389497;488077;42008.1598368037;43255.783721081825;45863.31205031927;62734;66346.66826665933;1151.7005578549638;1158.692946369213;1164.7612239491054;1199.898008669273;1200.765850659113;10252.794944101226;14414.85585144135;14829.98933558204;14939.925300373428;15042.849571504144;31918.36163276768;33253.667463326026;35981.820090899375;36330.27339453143;36541;45503;46002.30996534988;47661.76169119132;47730.522694772604;48034;3919.11819840545;9234.769130771785;9675.564599593175;9678.225741940769;9916.305858589829;7861.371090312876;8380.664773408995;8492.278156356779;11048.779024419628;11705;6860.8284792878585;7385.187629360874;7431.256874312742;7441.590712510864;7563.092428908566;6782.69477873487;7193.748218812526;7645.311921927053;7658.923410766044;7682.308592226726;7443.218462061622;7459.328660420588;7486.064241969754;7493.325600695964;7536;9427.952860235655;9804.65683701067;9843.16333111665;9952.203823693942;9957.701268961942;10020.799584008424;10286.948565257126;10292.433916134685;10459.581616735246;10481.056704896597 01:12:06 INFO - PROCESS | 5118 | |3;mootools.html;1475.4688312207604;1502.481643832878;1642.9014259144453;1784.5003399048262;1788;7113.075300210971;7240.239774823646;7300.1604815446235;7301.342879140876;7366.631668416585;7316.341529262365;7363.9631801840915;7400.555966641992;7407.6296185190795;7408.777736667895;2215.6787265846483;2239.1267405711787;2244.236959433792;2244.494988627562;2250.561140577588;2248.1457046322375;2276.3967548599635;2290.6678531612906;2294.0365046680436;2297.7242730872317;2139.1764170794277;2155.041006751996;2226.0428015953134;2239.4177513846435;2247.1011595361824;2218.179273668745;2254.391314345126;2255.8872056397113;2256.266713318178;2261.7738226177335;2265.3090807303765;2302.297799171252;2304.331743794298;2308.3421224950807;2308.5844547981355;7421.146568144624;7453.664585093684;7468.626568671545;7473.551586904803;7476;4409.382686423904;4517.164324599927;4541.591256786905;4572.359869618256;4572.817087316504;2876.8417737024456;2877.669068057179;2928.560715892612;2956.024511911064;2965.2142182321704;899.9595018224196;927.1423932862143;928.7074571509953;931.1573026411041;946.8343039968047;9969.40183588987;10074.244431667581;10078.79842403155;10084.69745907624;10089.596416143346;3859.614038596174;3935.960640393617;4030.093229023505;4042.0905296308097;4048.716589838683;8318.750437486886;8351.874721879176;8357.080721120794;8370.916290837014;8372.623231954576;4461.08547747711;4501.099780044005;4550.658700597469;4553.453585569753;4564.52072532386;4187.078842654611;4188.643965262926;4207.200631879933;4228.9577104228565;4230.576942305806;3167.5407065975305;3176.253580408602;3198.5681932938755;3208.5668434761474;3223.5003574446;976.2385339435252;982.9655962041437;984.1093810101869;987.2496902354262;1002.1281485107856;1048.4181279390011;1055.0662663542819;1092.5247517329988;1208.4803534480259;1320.452012414837;7056.858862822714;7108.537945033556;7119.288071192839;7123.608201548861;7125.75059872902;1020.9234307426973;1043.546057465005;1095.386583513235;1116.430620383594;1130.3387518301886;5536.169574563767;5538.9169162462595;5562.276904002454;5577.163425486209;5587;8523.786905327417;8602.18279263469;8714.912850871537;8732.650693972297;8767.912320876838;8567.571621418903;8606.225439710455;8614.310855131574;8628.654853805903;8683.131686831393;6958.721651133898;7000.859982800315;7010.334018268256;7021.89467157993;7055.7177712891935;6867.416269616939;6924.376806087476;6950.79147625572;6966.7213311469;6981.232064472802;7344.669489872862;7523.285287897641;7528.585927774025;7634.770956871303;7881.802954926173;7536.24637536242;7695.422843286664;7705.922940770521;7710.845783084419;7746.65140068687;6380.361963803768;6388.329225431263;6462.935370646233;6468.029795530708;6485.513586480938;6752.966235168793;6761.526693131434;6789.966050169717;6829.829254268683;6838.760643377458;6537.477001839937;6632.602043877383;6643.2360278568585;6705.329467053256;6780.423663988616;6465.806025819233;6553.475721942138;6576.967115164585;6613.371729685865;6737.629430381376;6629.933700663125;6651.933480665131;6656.467482601283;6657.933420665731;6663.900041499284;6134.294556125924;6182.474489668429;6210.130581718473;6253.6560489173535;6271.717772700148;6157.384261573807;6211.9689401554515;6243;6250.593711408744;6259.217597800275 01:12:06 INFO - PROCESS | 5118 | |4;prototype.html;332.61465994134426;337.43142804374617;339.3890996206827;341.95212670226186;347.25687029756324;6199.721012554434;6237.812865614039;6272.52956028298;6272.905906411407;6415.358464153594;6179.721912513936;6188.071789231618;6197.163382943312;6214.098955651439;6271.874562508747;4709.2229782085915;4742.1227072991605;4757.548032936883;4758.809647614091;4765.070811191819;4765.547273009076;4766.52334766524;4771.141194584973;4772.403449568804;4780.713157210561;4590.540945905416;4646.837360692376;4663.160631086403;4673.83641572545;4696.295555666643;4602.424696912886;4663.044075964436;4664.346991421204;4669.6731228814;4671.252599584084;4054.9862534366407;4055.7566546007333;4059.878203653895;4060.776657283848;4065.6137666921595;5870.941290587082;5898.793542226002;5902;5904.763809447617;5936.257967754031;5289.074411977888;5411;5419.268398766156;5435.918461223085;5476.123820188751;6537.117489138953;6547.770828021044;6555.3772391622715;6563;6598.043283723881;4472.5303843096335;4473.642108631302;4477.888052798674;4482.75344856036;4489.9551004490195;6804.591724496546;6831.931680683229;6863.2793556676825;6915.170179578483;6929.480288978347;4639.072185562901;4639.884002899887;4643.95356046442;4644.187267228222;4647.790849411785;4692.436907571045;4701.271302948048;4704.270838020112;4713.316569097462;4715.646326525456;5429.511343979061;5461.808836690776;5470.425605311465;5476.151196564539;5487.396386397493;6391.169148010729;6587.83530411734;6594.340565943463;6605.207375115017;6632.568883022588;1644.1450445768373;1667.6748034133227;1669.5325308913523;1670.0397271568897;1675.8826882118378;1084.078533246734;1094.4691824465128;1095.90684791792;1112.7329440934118;1116.0346300450053;6122.908156377658;6169;6194.566380353332;6216.222972128484;6223.595466294767;6784.185897692309;6841.692123854438;6848.657567121624;6848.863022739617;6923.58458492482;6133.233345831771;6211.223597050369;6212;6234.625922444668;6246.9062964054665;3678.4850120983083;3709.9072523187137;3720.3489389356755;3736.3274610569815;3737.588865224823;7005.719771209197;7035.261297563785;7040.331168538981;7049.259827718119;7050.717971281194;6909.343612356818;7042.61265630385;7055.400290975222;7067.858642827115;7071.858562828715;7177.497575169792;7274.1634712007735;7277.3086556777025;7281.5995120267835;7290.671919763623;6819.761308354382;6886.896696549456;6889.862202755817;6901.654917254217;6910.136232970879;6697.598144111369;6767.864642707217;6799.864002720017;6816.216135144522;6818.897716534157;7119.181294151032;7167.319104685047;7172.928270717226;7179.82050448722;7181.640917954186;4610.6542009350105;4643.024964757439;4649.721016738871;4652.232381657124;4656.231721766007;6729.5625784323865;6877.346652068046;6910.930890691029;6912.412444942236;6920.688569014507;6687.699053542699;6715.899261511179;6716.429103526059;6725.49558783103;6734.3602357775935;6656.83357916056;6686.83282917931;6691.1636045494315;6695.665216739241;6698.464122870061;6396.42432181106;6546.116274302908;6547.934520654732;6558.967205163944;6602.570832895846;6695.464362850863;6710.060591517094;6761.154855643044;6776.322367763184;6781.38967492928;6356.396142366468;6525.282218956006;6552.27924928267;6560.475161987125;6570.5400621956005 01:12:06 INFO - PROCESS | 5118 | |5;yui.html;837.9539125348111;860.4321148042292;877.736678996301;879.1340529578364;901.9807617392346;13448.731025379486;13464.596062118153;13475.528356507511;13522.256275904821;13609.38757755901;12907.483700651963;13080.345982700874;13080.934595327033;13082;13082.084254102192;659.5646873063766;675.3010633993817;806.6249194124761;819.901611806584;822.7326119011316;792.1444839573276;801.5831767480906;802.0575823407502;804.6781287485023;812.3176531713359;853.5390888920007;861.7371701631;861.9094995025526;863.7020228021354;865.6277800545763;851.4763420496412;852.9360297977677;860.0195776814468;862.2153840005565;862.2455351567379;630.6058713304185;633.0346222011424;633.2559242889632;635.7584118035163;637.101686621861;12956.157849739737;12986;13117.212967221998;13145.539906103337;13157;12783.488660453571;13085.084044116915;13231.338433078405;13343.933280333633;13392.665183370495;10494.842577361345;10503.548968776116;10687.14502839771;10747.946260268727;11035.83446248307;3579.2662504186837;3623.9852841204506;3642.7996460194677;3693.9445908311395;3725.497057897176;43252.3512147318;43599.12801743979;43639.563604363866;43749;43818.56181438208;9719.951400242953;9896.752581185385;9995.600175992879;10093.798124037477;10239.18086553074;17979.640407191782;17985.1007449627;18102.094895255184;18133.909330453527;18340.082995850422;7649.732259370895;7661.846763064707;7692.653830577638;7840.803979900434;8040;4092.7339722917914;4196.538380778112;4292.678049146264;4313.956860431418;4324.891877703082;2850.102217801386;2864.971350286512;2866.756325712296;2872.6983666715114;2883.480973424804;485.95869351104847;501.81182056728727;509.8648858052619;511.8797082685566;524.9790008399622;638.3999040901538;644.2326781814517;646.731606383355;675.6656346749226;717.9959495125022;7803.102643196105;8057.59712014397;8058.677652893936;8649.394542382099;8782.473051616924;626.8777588370224;648.9221293444817;669.5413641655482;675.4292622733782;681.7239018197638;3777.735558510878;3804.7336686431686;3916.4516967624554;3920.4511368408444;3934.6852251819787;56320.43679563234;56872;56998;57339.42660573425;57419.42580574224;46703.5329646706;47297.763511182224;47304.5269547307;47362.763186183845;47489.76255118702;42221;42326.36510452346;42368.15263694709;43257.78371108124;43534.564654353686;8104.432689711899;8140.796480087808;8173.141820109041;8406.411551191602;8469.280111190617;33872.15319617029;34094.14764630805;34149.21557466287;34183.145421364665;34634.48048279227;40846.387304191056;41053;41127.38308925309;42798.35802462903;43292.35061474017;11460.598879039528;11534.480948357177;11628.94185529067;11698.122640801803;11720.120990925545;12252.509899603916;12301.692457688629;12308.199967002116;12349.135560510678;12419.93790031044;10682.359058456517;10768.300060496043;10861.619843305447;11057.778844422906;11111.166662500184;10457.372557646566;10463.529141188817;10741.516631751747;10768.946155269174;11311.151663625096;10088.092071713581;10215.336003159771;10233.641822536176;10359.171266298526;10398.220133489867;9055.592498337723;9203.171714545722;9270.768230794283;9704.466254356079;9795.853062204214;9080.40977336471;9410.529473526432;9425.811483770423;9481;9485.525723713925 01:12:06 INFO - PROCESS | 5118 | __end_tp_report 01:12:06 INFO - PROCESS | 5118 | __start_cc_report 01:12:06 INFO - PROCESS | 5118 | _x_x_mozilla_cycle_collect,313 01:12:06 INFO - PROCESS | 5118 | __end_cc_report 01:12:06 INFO - PROCESS | 5118 | __startTimestamp1452244326306__endTimestamp 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | ------- Summary: start ------- 01:12:06 INFO - PROCESS | 5118 | Number of tests: 6 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | [#0] dojo.html Cycles:165 Average:5248.85 Median:5464.45 stddev:585.84 (10.7%) stddev-sans-first:562.55 01:12:06 INFO - PROCESS | 5118 | Values: 3087.1 3132.2 3137.2 3169.8 3175.6 5105.5 5137.2 5163.7 5241.2 5246.3 5201.3 5207.5 5252.7 5260.6 5309.6 4498.7 4772.3 4971.4 4987.2 4990.4 4766.5 4909.2 4951.6 4968.5 4968.6 4763.6 4770.9 4837.4 4864.0 4878.8 4819.0 4822.5 4843.7 4866.1 4891.0 4664.6 4803.2 4822.0 4825.3 4855.7 5070.3 5117.4 5141.4 5146.5 5159.0 5580.7 5604.9 5634.8 5638.4 5654.6 5498.9 5618.2 5637.3 5681.9 5697.5 5235.2 5272.1 5277.9 5293.1 5307.8 5733.6 5753.9 5766.1 5773.7 5779.9 5451.8 5547.8 5564.9 5567.9 5603.0 5731.0 5733.0 5734.0 5741.0 5748.3 5649.2 5666.3 5695.8 5697.2 5708.3 5385.5 5536.9 5615.8 5653.5 5702.5 4312.6 4317.8 4319.1 4325.8 4350.1 3824.9 3848.2 3884.6 3894.3 3901.4 5107.1 5233.6 5265.7 5284.1 5364.7 5653.5 5660.4 5666.7 5670.6 5687.2 5106.0 5273.8 5278.2 5280.0 5336.0 4763.0 4825.0 4868.6 4890.7 4903.4 5842.5 5854.5 5857.4 5860.5 5868.8 5559.2 5660.9 5662.0 5662.5 5664.0 5767.3 5804.2 5906.7 5907.5 5937.1 5577.3 5581.2 5587.8 5602.9 5612.4 5442.5 5583.9 5596.6 5651.4 5661.5 5532.9 5600.1 5600.8 5604.0 5630.3 5532.4 5606.0 5607.3 5627.1 5635.9 5267.4 5367.2 5483.8 5498.9 5530.3 5576.4 5605.8 5611.1 5612.9 5625.8 5450.2 5464.0 5464.5 5478.2 5488.1 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | [#1] ext.html Cycles:180 Average:43060.25 Median:34619.46 stddev:70870.54 (204.7%) stddev-sans-first:70997.33 01:12:06 INFO - PROCESS | 5118 | Values: 509.4 539.3 544.4 561.6 569.7 26948.5 34987.0 35123.8 35250.6 35308.5 37308.3 37391.6 37466.4 37569.2 37840.2 8240.8 8388.1 8435.7 8441.6 8450.0 8173.2 8300.5 8301.8 8312.4 8343.5 8352.4 8370.7 8396.8 8437.4 8438.5 8262.2 8360.2 8369.7 8602.3 8612.0 8395.1 8588.3 8608.3 8610.1 8625.5 38793.2 39002.6 39104.2 39107.4 39160.0 3001.1 3013.2 3191.0 3486.7 3489.0 29344.4 29644.9 29878.3 29935.6 29997.9 3442.9 3510.9 3566.1 3623.8 3681.1 191743.0 192787.0 193769.0 194133.0 194186.0 50301.7 51435.0 55514.4 55692.3 55718.7 65018.0 65575.3 66010.3 66053.3 66107.3 13798.6 13930.8 13933.2 13970.6 13976.1 11165.4 11208.3 11220.3 11236.2 11277.5 18565.0 18663.7 18672.3 18772.8 18867.2 7439.7 7634.7 7635.9 7707.5 7711.5 959.8 986.3 998.6 1007.5 1062.3 27915.4 28200.7 28383.0 28413.0 28495.7 1052.8 1117.6 1138.0 1155.8 1183.3 14467.9 14621.2 14628.8 14665.3 14717.3 299839.0 301594.0 302702.0 303973.0 305907.0 49925.3 50037.7 50044.7 50206.2 50384.5 1305.3 1311.1 1312.4 1322.4 1323.8 27344.0 28265.6 28276.4 28292.3 28612.6 44367.8 44459.0 44721.3 44981.0 45010.8 299689.0 300431.0 301591.0 301765.0 302110.0 30096.5 30792.4 30914.0 31002.5 31270.4 35795.3 36305.5 36521.5 36998.4 37024.1 31159.0 31363.2 31381.8 31567.4 32962.5 34014.1 34697.3 35022.6 35166.5 35247.5 33883.8 33908.8 34541.6 34736.0 34887.0 27414.0 30838.0 31249.5 31432.7 31586.8 23624.8 23840.2 24513.1 24670.9 26398.9 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | [#2] jquery.html Cycles:180 Average:23109.86 Median:45932.81 stddev:66883.06 (145.6%) stddev-sans-first:67048.85 01:12:06 INFO - PROCESS | 5118 | Values: 349.1 350.6 351.2 351.3 353.2 16547.2 16802.5 16825.2 17598.2 17914.0 10938.0 11032.3 11072.5 12262.5 16477.8 4893.8 5090.0 5136.7 5447.0 5454.0 5343.7 5449.8 5474.3 5492.2 5515.9 4391.0 5039.0 5043.2 5166.5 5355.5 5204.8 5214.3 5240.9 5244.2 5717.8 5453.5 5460.8 5469.4 5473.5 5520.8 12077.8 12430.8 18332.9 19852.4 19853.5 2004.8 2023.5 2030.5 2047.8 2100.5 9378.5 9740.4 11493.9 12353.0 12942.9 1815.9 1817.4 1853.6 1871.9 1925.1 54363.4 56115.7 57181.0 57259.4 57702.1 10014.6 10050.6 10054.7 10079.5 10151.0 12876.0 13102.9 13133.5 13179.1 13219.8 7257.8 7361.3 7397.4 7422.1 7545.4 6865.2 7156.8 7177.4 7206.2 7219.9 4282.7 4410.5 4428.2 4443.0 4483.7 1714.9 1807.4 1828.9 1836.7 1869.5 817.6 928.8 929.9 938.5 1045.7 15058.4 15648.9 15691.2 15764.6 16431.8 943.1 951.2 961.7 984.4 990.2 9315.8 9594.1 9667.9 9679.9 9796.4 381310.0 387867.0 389197.0 389497.0 488077.0 42008.2 43255.8 45863.3 62734.0 66346.7 1151.7 1158.7 1164.8 1199.9 1200.8 10252.8 14414.9 14830.0 14939.9 15042.8 31918.4 33253.7 35981.8 36330.3 36541.0 45503.0 46002.3 47661.8 47730.5 48034.0 3919.1 9234.8 9675.6 9678.2 9916.3 7861.4 8380.7 8492.3 11048.8 11705.0 6860.8 7385.2 7431.3 7441.6 7563.1 6782.7 7193.7 7645.3 7658.9 7682.3 7443.2 7459.3 7486.1 7493.3 7536.0 9428.0 9804.7 9843.2 9952.2 9957.7 10020.8 10286.9 10292.4 10459.6 10481.1 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | [#3] mootools.html Cycles:180 Average:5156.99 Median:6384.35 stddev:2609.41 (40.9%) stddev-sans-first:2602.06 01:12:06 INFO - PROCESS | 5118 | Values: 1475.5 1502.5 1642.9 1784.5 1788.0 7113.1 7240.2 7300.2 7301.3 7366.6 7316.3 7364.0 7400.6 7407.6 7408.8 2215.7 2239.1 2244.2 2244.5 2250.6 2248.1 2276.4 2290.7 2294.0 2297.7 2139.2 2155.0 2226.0 2239.4 2247.1 2218.2 2254.4 2255.9 2256.3 2261.8 2265.3 2302.3 2304.3 2308.3 2308.6 7421.1 7453.7 7468.6 7473.6 7476.0 4409.4 4517.2 4541.6 4572.4 4572.8 2876.8 2877.7 2928.6 2956.0 2965.2 900.0 927.1 928.7 931.2 946.8 9969.4 10074.2 10078.8 10084.7 10089.6 3859.6 3936.0 4030.1 4042.1 4048.7 8318.8 8351.9 8357.1 8370.9 8372.6 4461.1 4501.1 4550.7 4553.5 4564.5 4187.1 4188.6 4207.2 4229.0 4230.6 3167.5 3176.3 3198.6 3208.6 3223.5 976.2 983.0 984.1 987.2 1002.1 1048.4 1055.1 1092.5 1208.5 1320.5 7056.9 7108.5 7119.3 7123.6 7125.8 1020.9 1043.5 1095.4 1116.4 1130.3 5536.2 5538.9 5562.3 5577.2 5587.0 8523.8 8602.2 8714.9 8732.7 8767.9 8567.6 8606.2 8614.3 8628.7 8683.1 6958.7 7000.9 7010.3 7021.9 7055.7 6867.4 6924.4 6950.8 6966.7 6981.2 7344.7 7523.3 7528.6 7634.8 7881.8 7536.2 7695.4 7705.9 7710.8 7746.7 6380.4 6388.3 6462.9 6468.0 6485.5 6753.0 6761.5 6790.0 6829.8 6838.8 6537.5 6632.6 6643.2 6705.3 6780.4 6465.8 6553.5 6577.0 6613.4 6737.6 6629.9 6651.9 6656.5 6657.9 6663.9 6134.3 6182.5 6210.1 6253.7 6271.7 6157.4 6212.0 6243.0 6250.6 6259.2 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | [#4] prototype.html Cycles:180 Average:5524.65 Median:6215.16 stddev:1690.98 (27.2%) stddev-sans-first:1650.21 01:12:06 INFO - PROCESS | 5118 | Values: 332.6 337.4 339.4 342.0 347.3 6199.7 6237.8 6272.5 6272.9 6415.4 6179.7 6188.1 6197.2 6214.1 6271.9 4709.2 4742.1 4757.5 4758.8 4765.1 4765.5 4766.5 4771.1 4772.4 4780.7 4590.5 4646.8 4663.2 4673.8 4696.3 4602.4 4663.0 4664.3 4669.7 4671.3 4055.0 4055.8 4059.9 4060.8 4065.6 5870.9 5898.8 5902.0 5904.8 5936.3 5289.1 5411.0 5419.3 5435.9 5476.1 6537.1 6547.8 6555.4 6563.0 6598.0 4472.5 4473.6 4477.9 4482.8 4490.0 6804.6 6831.9 6863.3 6915.2 6929.5 4639.1 4639.9 4644.0 4644.2 4647.8 4692.4 4701.3 4704.3 4713.3 4715.6 5429.5 5461.8 5470.4 5476.2 5487.4 6391.2 6587.8 6594.3 6605.2 6632.6 1644.1 1667.7 1669.5 1670.0 1675.9 1084.1 1094.5 1095.9 1112.7 1116.0 6122.9 6169.0 6194.6 6216.2 6223.6 6784.2 6841.7 6848.7 6848.9 6923.6 6133.2 6211.2 6212.0 6234.6 6246.9 3678.5 3709.9 3720.3 3736.3 3737.6 7005.7 7035.3 7040.3 7049.3 7050.7 6909.3 7042.6 7055.4 7067.9 7071.9 7177.5 7274.2 7277.3 7281.6 7290.7 6819.8 6886.9 6889.9 6901.7 6910.1 6697.6 6767.9 6799.9 6816.2 6818.9 7119.2 7167.3 7172.9 7179.8 7181.6 4610.7 4643.0 4649.7 4652.2 4656.2 6729.6 6877.3 6910.9 6912.4 6920.7 6687.7 6715.9 6716.4 6725.5 6734.4 6656.8 6686.8 6691.2 6695.7 6698.5 6396.4 6546.1 6547.9 6559.0 6602.6 6695.5 6710.1 6761.2 6776.3 6781.4 6356.4 6525.3 6552.3 6560.5 6570.5 01:12:06 INFO - PROCESS | 5118 | 01:12:06 INFO - PROCESS | 5118 | [#5] yui.html Cycles:180 Average:13287.36 Median:43275.07 stddev:15013.84 (34.7%) stddev-sans-first:15026.85 01:12:06 INFO - PROCESS | 5118 | Values: 838.0 860.4 877.7 879.1 902.0 13448.7 13464.6 13475.5 13522.3 13609.4 12907.5 13080.3 13080.9 13082.0 13082.1 659.6 675.3 806.6 819.9 822.7 792.1 801.6 802.1 804.7 812.3 853.5 861.7 861.9 863.7 865.6 851.5 852.9 860.0 862.2 862.2 630.6 633.0 633.3 635.8 637.1 12956.2 12986.0 13117.2 13145.5 13157.0 12783.5 13085.1 13231.3 13343.9 13392.7 10494.8 10503.5 10687.1 10747.9 11035.8 3579.3 3624.0 3642.8 3693.9 3725.5 43252.4 43599.1 43639.6 43749.0 43818.6 9720.0 9896.8 9995.6 10093.8 10239.2 17979.6 17985.1 18102.1 18133.9 18340.1 7649.7 7661.8 7692.7 7840.8 8040.0 4092.7 4196.5 4292.7 4314.0 4324.9 2850.1 2865.0 2866.8 2872.7 2883.5 486.0 501.8 509.9 511.9 525.0 638.4 644.2 646.7 675.7 718.0 7803.1 8057.6 8058.7 8649.4 8782.5 626.9 648.9 669.5 675.4 681.7 3777.7 3804.7 3916.5 3920.5 3934.7 56320.4 56872.0 56998.0 57339.4 57419.4 46703.5 47297.8 47304.5 47362.8 47489.8 42221.0 42326.4 42368.2 43257.8 43534.6 8104.4 8140.8 8173.1 8406.4 8469.3 33872.2 34094.1 34149.2 34183.1 34634.5 40846.4 41053.0 41127.4 42798.4 43292.4 11460.6 11534.5 11628.9 11698.1 11720.1 12252.5 12301.7 12308.2 12349.1 12419.9 10682.4 10768.3 10861.6 11057.8 11111.2 10457.4 10463.5 10741.5 10768.9 11311.2 10088.1 10215.3 10233.6 10359.2 10398.2 9055.6 9203.2 9270.8 9704.5 9795.9 9080.4 9410.5 9425.8 9481.0 9485.5 01:12:06 INFO - PROCESS | 5118 | -------- Summary: end -------- 01:12:06 INFO - PROCESS | 5118 | 01:12:07 INFO - TEST-INFO | 5118: exit 0 01:12:07 INFO - TEST-OK | dromaeo_css | took 1111235ms 01:12:07 INFO - TEST-START | kraken 01:12:07 INFO - operating with platform_type : linux_ 01:12:07 INFO - Initialising browser for kraken test... 01:12:07 INFO - TEST-INFO | started process 5356 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAFGo56/profile http://localhost:36803/getInfo.html) 01:12:11 INFO - PROCESS | 5356 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:12:12 INFO - PROCESS | 5356 | __metrics Screen width/height:1600/1200 01:12:12 INFO - PROCESS | 5356 | colorDepth:24 01:12:12 INFO - PROCESS | 5356 | Browser inner width/height: 1024/697 01:12:12 INFO - PROCESS | 5356 | __metrics 01:12:12 INFO - PROCESS | 5356 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:12:13 INFO - TEST-INFO | 5356: exit 0 01:12:13 INFO - Browser initialized. 01:12:13 INFO - Running cycle 1/1 for kraken test... 01:12:13 INFO - TEST-INFO | started process 5477 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAFGo56/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:12:25 INFO - PROCESS | 5477 | RSS: Main: 150425600 01:12:25 INFO - PROCESS | 5477 | 01:12:28 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36803/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:28 INFO - PROCESS | 5477 | RSS: Main: 151785472 01:12:28 INFO - PROCESS | 5477 | 01:12:31 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36803/tests/kraken/driver.html?testName=audio-dft) 01:12:32 INFO - PROCESS | 5477 | RSS: Main: 152199168 01:12:32 INFO - PROCESS | 5477 | 01:12:34 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36803/tests/kraken/driver.html?testName=audio-fft) 01:12:35 INFO - PROCESS | 5477 | RSS: Main: 145768448 01:12:35 INFO - PROCESS | 5477 | 01:12:37 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36803/tests/kraken/driver.html?testName=audio-oscillator) 01:12:38 INFO - PROCESS | 5477 | RSS: Main: 146214912 01:12:38 INFO - PROCESS | 5477 | 01:12:40 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:12:41 INFO - PROCESS | 5477 | RSS: Main: 147730432 01:12:41 INFO - PROCESS | 5477 | 01:12:44 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36803/tests/kraken/driver.html?testName=imaging-darkroom) 01:12:44 INFO - PROCESS | 5477 | RSS: Main: 146345984 01:12:44 INFO - PROCESS | 5477 | 01:12:48 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36803/tests/kraken/driver.html?testName=imaging-desaturate) 01:12:48 INFO - PROCESS | 5477 | RSS: Main: 147410944 01:12:48 INFO - PROCESS | 5477 | 01:12:51 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36803/tests/kraken/driver.html?testName=json-parse-financial) 01:12:52 INFO - PROCESS | 5477 | RSS: Main: 147558400 01:12:52 INFO - PROCESS | 5477 | 01:12:53 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:12:54 INFO - PROCESS | 5477 | RSS: Main: 149229568 01:12:54 INFO - PROCESS | 5477 | 01:12:56 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:12:56 INFO - PROCESS | 5477 | RSS: Main: 149061632 01:12:56 INFO - PROCESS | 5477 | 01:12:58 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:12:59 INFO - PROCESS | 5477 | RSS: Main: 147591168 01:12:59 INFO - PROCESS | 5477 | 01:13:01 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:13:02 INFO - PROCESS | 5477 | RSS: Main: 149778432 01:13:02 INFO - PROCESS | 5477 | 01:13:05 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:13:05 INFO - PROCESS | 5477 | RSS: Main: 149618688 01:13:05 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:36803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36803/tests/kraken/driver.html?testName=ai-astar) 01:13:07 INFO - PROCESS | 5477 | RSS: Main: 149856256 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | __start_tp_report 01:13:07 INFO - PROCESS | 5477 | _x_x_mozilla_page_load 01:13:07 INFO - PROCESS | 5477 | _x_x_mozilla_page_load_details 01:13:07 INFO - PROCESS | 5477 | |i|pagename|runs| 01:13:07 INFO - PROCESS | 5477 | |0;ai-astar;111;106;112;109;114;120;111;110;111;110 01:13:07 INFO - PROCESS | 5477 | |1;audio-beat-detection;156;131;155;166;134;168;156;127;176;132 01:13:07 INFO - PROCESS | 5477 | |2;audio-dft;165;162;162;163;162;161;162;166;172;164 01:13:07 INFO - PROCESS | 5477 | |3;audio-fft;74;75;81;75;71;73;132;73;72;71 01:13:07 INFO - PROCESS | 5477 | |4;audio-oscillator;96;95;149;96;97;96;149;96;97;143 01:13:07 INFO - PROCESS | 5477 | |5;imaging-gaussian-blur;110;109;110;110;110;110;109;109;111;110 01:13:07 INFO - PROCESS | 5477 | |6;imaging-darkroom;147;146;148;146;148;147;147;147;145;147 01:13:07 INFO - PROCESS | 5477 | |7;imaging-desaturate;96;97;96;96;96;98;96;96;96;95 01:13:07 INFO - PROCESS | 5477 | |8;json-parse-financial;58;59;59;60;60;70;59;58;60;57 01:13:07 INFO - PROCESS | 5477 | |9;json-stringify-tinderbox;67;66;67;67;67;66;66;67;68;67 01:13:07 INFO - PROCESS | 5477 | |10;stanford-crypto-aes;85;87;86;86;87;88;88;90;88;86 01:13:07 INFO - PROCESS | 5477 | |11;stanford-crypto-ccm;123;118;119;120;120;127;133;119;122;128 01:13:07 INFO - PROCESS | 5477 | |12;stanford-crypto-pbkdf2;143;154;155;154;155;159;155;155;156;162 01:13:07 INFO - PROCESS | 5477 | |13;stanford-crypto-sha256-iterative;68;68;68;69;69;68;69;68;68;69 01:13:07 INFO - PROCESS | 5477 | __end_tp_report 01:13:07 INFO - PROCESS | 5477 | __start_cc_report 01:13:07 INFO - PROCESS | 5477 | _x_x_mozilla_cycle_collect,730 01:13:07 INFO - PROCESS | 5477 | __end_cc_report 01:13:07 INFO - PROCESS | 5477 | __startTimestamp1452244387562__endTimestamp 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | ------- Summary: start ------- 01:13:07 INFO - PROCESS | 5477 | Number of tests: 14 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:3.66 (3.3%) stddev-sans-first:3.88 01:13:07 INFO - PROCESS | 5477 | Values: 111.0 106.0 112.0 109.0 114.0 120.0 111.0 110.0 111.0 110.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:156.00 stddev:17.71 (11.4%) stddev-sans-first:18.66 01:13:07 INFO - PROCESS | 5477 | Values: 156.0 131.0 155.0 166.0 134.0 168.0 156.0 127.0 176.0 132.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.25 (2.0%) stddev-sans-first:3.42 01:13:07 INFO - PROCESS | 5477 | Values: 165.0 162.0 162.0 163.0 162.0 161.0 162.0 166.0 172.0 164.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#3] audio-fft Cycles:10 Average:79.70 Median:73.50 stddev:18.60 (25.3%) stddev-sans-first:19.62 01:13:07 INFO - PROCESS | 5477 | Values: 74.0 75.0 81.0 75.0 71.0 73.0 132.0 73.0 72.0 71.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:96.00 stddev:24.63 (25.7%) stddev-sans-first:25.48 01:13:07 INFO - PROCESS | 5477 | Values: 96.0 95.0 149.0 96.0 97.0 96.0 149.0 96.0 97.0 143.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 01:13:07 INFO - PROCESS | 5477 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 111.0 110.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 01:13:07 INFO - PROCESS | 5477 | Values: 147.0 146.0 148.0 146.0 148.0 147.0 147.0 147.0 145.0 147.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 01:13:07 INFO - PROCESS | 5477 | Values: 96.0 97.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 95.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.50 stddev:3.65 (6.1%) stddev-sans-first:3.80 01:13:07 INFO - PROCESS | 5477 | Values: 58.0 59.0 59.0 60.0 60.0 70.0 59.0 58.0 60.0 57.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 01:13:07 INFO - PROCESS | 5477 | Values: 67.0 66.0 67.0 67.0 67.0 66.0 66.0 67.0 68.0 67.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.50 stddev:1.45 (1.7%) stddev-sans-first:1.32 01:13:07 INFO - PROCESS | 5477 | Values: 85.0 87.0 86.0 86.0 87.0 88.0 88.0 90.0 88.0 86.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:122.50 stddev:4.91 (4.0%) stddev-sans-first:5.21 01:13:07 INFO - PROCESS | 5477 | Values: 123.0 118.0 119.0 120.0 120.0 127.0 133.0 119.0 122.0 128.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:4.85 (3.1%) stddev-sans-first:2.67 01:13:07 INFO - PROCESS | 5477 | Values: 143.0 154.0 155.0 154.0 155.0 159.0 155.0 155.0 156.0 162.0 01:13:07 INFO - PROCESS | 5477 | 01:13:07 INFO - PROCESS | 5477 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:13:07 INFO - PROCESS | 5477 | Values: 68.0 68.0 68.0 69.0 69.0 68.0 69.0 68.0 68.0 69.0 01:13:07 INFO - PROCESS | 5477 | -------- Summary: end -------- 01:13:07 INFO - PROCESS | 5477 | 01:13:08 INFO - TEST-INFO | 5477: exit 0 01:13:08 INFO - TEST-OK | kraken | took 61424ms 01:13:08 INFO - TEST-START | v8_7 01:13:08 INFO - operating with platform_type : linux_ 01:13:08 INFO - Initialising browser for v8_7 test... 01:13:08 INFO - TEST-INFO | started process 5764 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1oZcH1/profile http://localhost:36803/getInfo.html) 01:13:13 INFO - PROCESS | 5764 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:13:14 INFO - PROCESS | 5764 | __metrics Screen width/height:1600/1200 01:13:14 INFO - PROCESS | 5764 | colorDepth:24 01:13:14 INFO - PROCESS | 5764 | Browser inner width/height: 1024/697 01:13:14 INFO - PROCESS | 5764 | __metrics 01:13:14 INFO - PROCESS | 5764 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:13:14 INFO - PROCESS | 5764 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 01:13:15 INFO - TEST-INFO | 5764: exit 0 01:13:15 INFO - Browser initialized. 01:13:15 INFO - Running cycle 1/1 for v8_7 test... 01:13:15 INFO - TEST-INFO | started process 5889 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1oZcH1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:13:27 INFO - PROCESS | 5889 | RSS: Main: 150294528 01:13:27 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | Cycle 1(1): loaded http://localhost:36803/tests/v8_7/run.html (next: http://localhost:36803/tests/v8_7/run.html) 01:13:49 INFO - PROCESS | 5889 | RSS: Main: 145924096 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | __start_tp_report 01:13:49 INFO - PROCESS | 5889 | _x_x_mozilla_page_load 01:13:49 INFO - PROCESS | 5889 | _x_x_mozilla_page_load_details 01:13:49 INFO - PROCESS | 5889 | |i|pagename|runs| 01:13:49 INFO - PROCESS | 5889 | |0;Richards;165.23463317911435 01:13:49 INFO - PROCESS | 5889 | |1;DeltaBlue;187.79342723004694 01:13:49 INFO - PROCESS | 5889 | |2;Encrypt;280.19052956010086 01:13:49 INFO - PROCESS | 5889 | |3;Decrypt;5208.333333333333 01:13:49 INFO - PROCESS | 5889 | |4;RayTrace;1063.8297872340424 01:13:49 INFO - PROCESS | 5889 | |5;Earley;753.5795026375282 01:13:49 INFO - PROCESS | 5889 | |6;Boyer;12292.682926829268 01:13:49 INFO - PROCESS | 5889 | |7;RegExp;41061.22448979592 01:13:49 INFO - PROCESS | 5889 | |8;Splay;605.3268765133172 01:13:49 INFO - PROCESS | 5889 | |9;NavierStokes;4817.307692307692 01:13:49 INFO - PROCESS | 5889 | __end_tp_report 01:13:49 INFO - PROCESS | 5889 | __startTimestamp1452244429851__endTimestamp 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | ------- Summary: start ------- 01:13:49 INFO - PROCESS | 5889 | Number of tests: 10 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#0] Richards Cycles:1 Average:165.23 Median:165.23 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 165.2 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 187.8 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 280.2 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 5208.3 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 1063.8 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#5] Earley Cycles:1 Average:753.58 Median:753.58 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 753.6 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 12292.7 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#7] RegExp Cycles:1 Average:41061.22 Median:41061.22 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 41061.2 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#8] Splay Cycles:1 Average:605.33 Median:605.33 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 605.3 01:13:49 INFO - PROCESS | 5889 | 01:13:49 INFO - PROCESS | 5889 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 01:13:49 INFO - PROCESS | 5889 | Values: 4817.3 01:13:49 INFO - PROCESS | 5889 | -------- Summary: end -------- 01:13:49 INFO - PROCESS | 5889 | 01:13:50 INFO - TEST-INFO | 5889: exit 0 01:13:50 INFO - TEST-OK | v8_7 | took 42251ms 01:13:50 INFO - SUITE-END | took 1214s 01:13:50 INFO - Completed test suite (00:20:15) 01:13:50 INFO - Working with test: dromaeo_css 01:13:50 INFO - Generating results file: dromaeo_css 01:13:50 INFO - Working with test: kraken 01:13:50 INFO - Generating results file: kraken 01:13:50 INFO - javascript benchmark 01:13:50 INFO - Working with test: v8_7 01:13:50 INFO - Generating results file: v8_7 01:13:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 01:13:51 INFO - process_Request line: dromaeo_css 6750.78 graph.html#tests=[[72,1,43]] 01:13:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:51 INFO - process_Request line: kraken 1529.30 graph.html#tests=[[232,1,43]] 01:13:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:51 INFO - process_Request line: v8_7 20291.31 graph.html#tests=[[230,1,43]] 01:13:51 INFO - RETURN: dromaeo_css: 6750.78 01:13:51 INFO - RETURN: kraken: 1529.30 01:13:51 INFO - RETURN: v8_7: 20291.31 01:13:51 INFO - javascript benchmark 01:13:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3087.1201707513355, 3132.2482604175007, 3137.215696075981, 3169.825659588722, 3175.555422240887, 5105.540501354877, 5137.203733421321, 5163.664361816479, 5241.1876159195335, 5246.291750613666, 5201.349831271091, 5207.505286997739, 5252.71110088945, 5260.552853007499, 5309.601779866506, 4498.730076195422, 4772.260299653551, 4971.428285747149, 4987.1521841286885, 4990.401151861782, 4766.499517550659, 4909.214525675892, 4951.603871690274, 4968.527989840977, 4968.577670897978, 4763.61891048717, 4770.880727981794, 4837.371141751585, 4864.027194561102, 4878.804847806084, 4818.951810481885, 4822.517748225149, 4843.66094373394, 4866.051120031595, 4890.95109048912, 4664.603508701731, 4803.231482962709, 4822.0, 4825.324454576362, 4855.708657480563, 5070.264811602334, 5117.385913690381, 5141.434442211354, 5146.536811686929, 5159.0, 5580.720963951827, 5604.859878503029, 5634.802781902655, 5638.40796716343, 5654.6324488908085, 5498.862528436821, 5618.213450116987, 5637.295338082739, 5681.914771278434, 5697.544196464273, 5235.240890070919, 5272.130098533776, 5277.86805329866, 5293.100172970604, 5307.787688492494, 5733.569982251348, 5753.85615359611, 5766.135079738073, 5773.6824474654295, 5779.884402312015, 5451.809186678447, 5547.805826796042, 5564.860878478071, 5567.916481252784, 5602.971985140048, 5730.971345143247, 5732.971335143381, 5733.971330143323, 5740.971295143581, 5748.281464816898, 5649.209110724501, 5666.291713535808, 5695.800646977336, 5697.202391665171, 5708.286464191976, 5385.461453854661, 5536.861578460571, 5615.803446879339, 5653.547716182696, 5702.543796496353, 4312.568743125662, 4317.84887528935, 4319.136172765459, 4325.826966921288, 4350.129974005212, 3824.904377390532, 3848.1534062506203, 3884.592117827644, 3894.337962546374, 3901.3757798752063, 5107.080725469451, 5233.633645644768, 5265.736713164327, 5284.101702710548, 5364.7317634118135, 5653.4629210225785, 5660.433956604306, 5666.688332141772, 5670.603057785916, 5687.203791469197, 5106.0, 5273.762680679379, 5278.234655974862, 5280.049591073567, 5335.973320133375, 4762.976185119052, 4825.0, 4868.634852386085, 4890.682105663121, 4903.436104847917, 5842.532597392198, 5854.531637468992, 5857.355690874, 5860.501857342088, 5868.765249390062, 5559.193916881949, 5660.858478537904, 5662.03745363281, 5662.5469962402085, 5663.9716801415725, 5767.307923049261, 5804.24544809189, 5906.675132867734, 5907.527397808251, 5937.109433584997, 5577.27495425592, 5581.246531718166, 5587.804426845041, 5602.85992850182, 5612.354579223442, 5442.455754424526, 5583.944160558505, 5596.636218645938, 5651.350094739158, 5661.46216109469, 5532.889342213052, 5600.103983362643, 5600.775968961359, 5604.019296622993, 5630.324361076697, 5532.391436942014, 5606.0, 5607.299087614048, 5627.127795191752, 5635.9436405635415, 5267.367915850123, 5367.221752845738, 5483.8080667176455, 5498.890022199614, 5530.281063461724, 5576.358718747396, 5605.831825045255, 5611.074172761449, 5612.8877422450505, 5625.831225063254, 5450.2369668247275, 5464.0, 5464.453554644504, 5478.205660179331, 5488.067028605067], "unit": "score", "name": "dojo.html", "value": 5210.6333912699265}, {"lowerIsBetter": false, "replicates": [509.3607522559188, 539.3393093460511, 544.3821262866645, 561.5647872898503, 569.7066011004331, 26948.461030779374, 34987.0, 35123.82438087806, 35250.64749352502, 35308.47037294439, 37308.253834923285, 37391.62608373915, 37466.4380034299, 37569.24861502768, 37840.24319513608, 8240.752777416672, 8388.119247479019, 8435.662573497053, 8441.620127094266, 8449.95775021124, 8173.223543763363, 8300.543470109142, 8301.750947471555, 8312.376571757111, 8343.45767525109, 8352.373571982125, 8370.707025254118, 8396.83206335873, 8437.367197460184, 8438.451500652469, 8262.215089566482, 8360.163983601622, 8369.665213391487, 8602.31181505478, 8611.95694021526, 8395.118512556215, 8588.269997050258, 8608.268297194745, 8610.052894181636, 8625.482471051695, 38793.22413551741, 39002.60997390018, 39104.21791564181, 39107.41338879919, 39160.0, 3001.0846691759007, 3013.186439661301, 3191.0, 3486.703630191437, 3488.988193423904, 29344.413111737646, 29644.851775741197, 29878.253043673863, 29935.550966735518, 29997.850010750026, 3442.896713098611, 3510.859565617372, 3566.1262990567216, 3623.832483402769, 3681.0613293610227, 191743.0, 192787.0, 193769.0, 194133.0, 194186.02906985517, 50301.74849125731, 51434.97130057378, 55514.44485555174, 55692.32923012316, 55718.72140639271, 65018.0, 65575.34424655788, 66010.33989660042, 66053.33946660568, 66107.33892661108, 13798.586042418743, 13930.815880650056, 13933.233672147926, 13970.580882573538, 13976.091554048955, 11165.385903775208, 11208.27146235492, 11220.270682405617, 11236.157288203418, 11277.492512836778, 18565.0, 18663.72004419935, 18672.253109875724, 18772.81227187738, 18867.150978206013, 7439.665215065335, 7634.6946122154495, 7635.885461718079, 7707.535568242016, 7711.537307761552, 959.8080383923243, 986.28001558861, 998.5556427389741, 1007.5466040281756, 1062.2617280989639, 27915.441691166063, 28200.71799282022, 28383.0, 28413.0, 28495.715042849723, 1052.7947050325267, 1117.6088369070924, 1138.0269869261663, 1155.8035134027236, 1183.2663748476, 14467.855321446861, 14621.19583422922, 14628.780568291484, 14665.266736663125, 14717.264136793117, 299839.0, 301594.0, 302702.0, 303973.0, 305907.0, 49925.25112123321, 50037.74981125071, 50044.74977625089, 50206.24690629644, 50384.496155038716, 1305.3147097773556, 1311.0560396514495, 1312.3700623700486, 1322.3983087695076, 1323.8080478330587, 27344.0, 28265.57601635936, 28276.396351368236, 28292.292692682026, 28612.57081143826, 44367.77816110899, 44459.0, 44721.32918006167, 44981.0, 45010.77494612506, 299689.0, 300431.0, 301591.0, 301765.0, 302110.0, 30096.548551771302, 30792.384152317278, 30914.0, 31002.534961975136, 31270.374592508477, 35795.284094318486, 36305.45541816928, 36521.452178216816, 36998.44502332414, 37024.07439814026, 31159.0, 31363.215919602193, 31381.8430907844, 31567.36865262728, 32962.5055624161, 34014.149646259044, 34697.306053878274, 35022.64977350194, 35166.472502911965, 35247.471287931214, 33883.781040801085, 33908.830455847565, 34541.61833526631, 34736.0, 34887.0, 27414.0, 30837.99553029046, 31249.531257030707, 31432.685673142976, 31586.842065789522, 23624.763752362258, 23840.165594204118, 24513.142040028513, 24670.862628717485, 26398.86800565985], "unit": "score", "name": "ext.html", "value": 17588.921274076103}, {"lowerIsBetter": false, "replicates": [349.1271820448877, 350.6388419927476, 351.15722266560255, 351.33246831021074, 353.16476532999434, 16547.172641367943, 16802.495925122235, 16825.242864071115, 17598.20808063637, 17914.014729189905, 10938.0, 11032.28290161139, 11072.501737421815, 12262.509499620026, 16477.83522164778, 4893.755312234392, 5090.0328937501945, 5136.691798492084, 5447.0, 5454.0, 5343.744220108271, 5449.83650490484, 5474.315710536183, 5492.176173573976, 5515.944840551583, 4390.978045109786, 5039.0, 5043.218301163325, 5166.483351664841, 5355.544778693816, 5204.791808327663, 5214.296070030536, 5240.921386179191, 5244.213367994793, 5717.828465146011, 5453.481919217668, 5460.836174914759, 5469.425710300401, 5473.452654734495, 5520.779168833242, 12077.758444831143, 12430.75138497234, 18332.90833545837, 19852.404427867186, 19853.50366240841, 2004.7894971028124, 2023.5143565544163, 2030.4923769057737, 2047.7952204779551, 2100.527381339202, 9378.53107344637, 9740.415575065519, 11493.885061149365, 12353.0, 12942.935285323512, 1815.9364422245158, 1817.3820900893759, 1853.5922097138607, 1871.897045662488, 1925.1144473542188, 54363.424491111655, 56115.71942140304, 57181.0, 57259.42740572582, 57702.13446798259, 10014.599416023424, 10050.59797608102, 10054.74863128413, 10079.496025198858, 10151.0, 12875.969922406184, 13102.934485327512, 13133.474661013644, 13179.07746457758, 13219.801702974462, 7257.782266532013, 7361.30067643573, 7397.37122344596, 7422.109346878409, 7545.396368290523, 6865.176178858569, 7156.785296441115, 7177.4258059355125, 7206.243344448862, 7219.8917016244795, 4282.721623094489, 4410.4927933287445, 4428.22506061438, 4443.0, 4483.730976141442, 1714.9485515434558, 1807.4396936949588, 1828.9268429262681, 1836.6785812482763, 1869.5326168457887, 817.5993763056059, 928.8467402878584, 929.8930622978444, 938.5119737736339, 1045.6758404894356, 15058.397664093533, 15648.92175539115, 15691.215439227994, 15764.605884852741, 16431.838793927946, 943.118184497497, 951.1772316945792, 961.6730311693917, 984.4093543873762, 990.2276224544867, 9315.813683726288, 9594.1365277124, 9667.854982175273, 9679.854802177973, 9796.412215267106, 381310.0, 387867.0, 389197.0, 389497.0, 488077.0, 42008.1598368037, 43255.783721081825, 45863.31205031927, 62734.0, 66346.66826665933, 1151.7005578549638, 1158.692946369213, 1164.7612239491054, 1199.898008669273, 1200.765850659113, 10252.794944101226, 14414.85585144135, 14829.98933558204, 14939.925300373428, 15042.849571504144, 31918.36163276768, 33253.667463326026, 35981.820090899375, 36330.27339453143, 36541.0, 45503.0, 46002.30996534988, 47661.76169119132, 47730.522694772604, 48034.0, 3919.11819840545, 9234.769130771785, 9675.564599593175, 9678.225741940769, 9916.305858589829, 7861.371090312876, 8380.664773408995, 8492.278156356779, 11048.779024419628, 11705.0, 6860.8284792878585, 7385.187629360874, 7431.256874312742, 7441.590712510864, 7563.092428908566, 6782.69477873487, 7193.748218812526, 7645.311921927053, 7658.923410766044, 7682.308592226726, 7443.218462061622, 7459.328660420588, 7486.064241969754, 7493.325600695964, 7536.0, 9427.952860235655, 9804.65683701067, 9843.16333111665, 9952.203823693942, 9957.701268961942, 10020.799584008424, 10286.948565257126, 10292.433916134685, 10459.581616735246, 10481.056704896597], "unit": "score", "name": "jquery.html", "value": 7861.280043625264}, {"lowerIsBetter": false, "replicates": [1475.4688312207604, 1502.481643832878, 1642.9014259144453, 1784.5003399048262, 1788.0, 7113.075300210971, 7240.239774823646, 7300.1604815446235, 7301.342879140876, 7366.631668416585, 7316.341529262365, 7363.9631801840915, 7400.555966641992, 7407.6296185190795, 7408.777736667895, 2215.6787265846483, 2239.1267405711787, 2244.236959433792, 2244.494988627562, 2250.561140577588, 2248.1457046322375, 2276.3967548599635, 2290.6678531612906, 2294.0365046680436, 2297.7242730872317, 2139.1764170794277, 2155.041006751996, 2226.0428015953134, 2239.4177513846435, 2247.1011595361824, 2218.179273668745, 2254.391314345126, 2255.8872056397113, 2256.266713318178, 2261.7738226177335, 2265.3090807303765, 2302.297799171252, 2304.331743794298, 2308.3421224950807, 2308.5844547981355, 7421.146568144624, 7453.664585093684, 7468.626568671545, 7473.551586904803, 7476.0, 4409.382686423904, 4517.164324599927, 4541.591256786905, 4572.359869618256, 4572.817087316504, 2876.8417737024456, 2877.669068057179, 2928.560715892612, 2956.024511911064, 2965.2142182321704, 899.9595018224196, 927.1423932862143, 928.7074571509953, 931.1573026411041, 946.8343039968047, 9969.40183588987, 10074.244431667581, 10078.79842403155, 10084.69745907624, 10089.596416143346, 3859.614038596174, 3935.960640393617, 4030.093229023505, 4042.0905296308097, 4048.716589838683, 8318.750437486886, 8351.874721879176, 8357.080721120794, 8370.916290837014, 8372.623231954576, 4461.08547747711, 4501.099780044005, 4550.658700597469, 4553.453585569753, 4564.52072532386, 4187.078842654611, 4188.643965262926, 4207.200631879933, 4228.9577104228565, 4230.576942305806, 3167.5407065975305, 3176.253580408602, 3198.5681932938755, 3208.5668434761474, 3223.5003574446, 976.2385339435252, 982.9655962041437, 984.1093810101869, 987.2496902354262, 1002.1281485107856, 1048.4181279390011, 1055.0662663542819, 1092.5247517329988, 1208.4803534480259, 1320.452012414837, 7056.858862822714, 7108.537945033556, 7119.288071192839, 7123.608201548861, 7125.75059872902, 1020.9234307426973, 1043.546057465005, 1095.386583513235, 1116.430620383594, 1130.3387518301886, 5536.169574563767, 5538.9169162462595, 5562.276904002454, 5577.163425486209, 5587.0, 8523.786905327417, 8602.18279263469, 8714.912850871537, 8732.650693972297, 8767.912320876838, 8567.571621418903, 8606.225439710455, 8614.310855131574, 8628.654853805903, 8683.131686831393, 6958.721651133898, 7000.859982800315, 7010.334018268256, 7021.89467157993, 7055.7177712891935, 6867.416269616939, 6924.376806087476, 6950.79147625572, 6966.7213311469, 6981.232064472802, 7344.669489872862, 7523.285287897641, 7528.585927774025, 7634.770956871303, 7881.802954926173, 7536.24637536242, 7695.422843286664, 7705.922940770521, 7710.845783084419, 7746.65140068687, 6380.361963803768, 6388.329225431263, 6462.935370646233, 6468.029795530708, 6485.513586480938, 6752.966235168793, 6761.526693131434, 6789.966050169717, 6829.829254268683, 6838.760643377458, 6537.477001839937, 6632.602043877383, 6643.2360278568585, 6705.329467053256, 6780.423663988616, 6465.806025819233, 6553.475721942138, 6576.967115164585, 6613.371729685865, 6737.629430381376, 6629.933700663125, 6651.933480665131, 6656.467482601283, 6657.933420665731, 6663.900041499284, 6134.294556125924, 6182.474489668429, 6210.130581718473, 6253.6560489173535, 6271.717772700148, 6157.384261573807, 6211.9689401554515, 6243.0, 6250.593711408744, 6259.217597800275], "unit": "score", "name": "mootools.html", "value": 4266.114670550489}, {"lowerIsBetter": false, "replicates": [332.61465994134426, 337.43142804374617, 339.3890996206827, 341.95212670226186, 347.25687029756324, 6199.721012554434, 6237.812865614039, 6272.52956028298, 6272.905906411407, 6415.358464153594, 6179.721912513936, 6188.071789231618, 6197.163382943312, 6214.098955651439, 6271.874562508747, 4709.2229782085915, 4742.1227072991605, 4757.548032936883, 4758.809647614091, 4765.070811191819, 4765.547273009076, 4766.52334766524, 4771.141194584973, 4772.403449568804, 4780.713157210561, 4590.540945905416, 4646.837360692376, 4663.160631086403, 4673.83641572545, 4696.295555666643, 4602.424696912886, 4663.044075964436, 4664.346991421204, 4669.6731228814, 4671.252599584084, 4054.9862534366407, 4055.7566546007333, 4059.878203653895, 4060.776657283848, 4065.6137666921595, 5870.941290587082, 5898.793542226002, 5902.0, 5904.763809447617, 5936.257967754031, 5289.074411977888, 5411.0, 5419.268398766156, 5435.918461223085, 5476.123820188751, 6537.117489138953, 6547.770828021044, 6555.3772391622715, 6563.0, 6598.043283723881, 4472.5303843096335, 4473.642108631302, 4477.888052798674, 4482.75344856036, 4489.9551004490195, 6804.591724496546, 6831.931680683229, 6863.2793556676825, 6915.170179578483, 6929.480288978347, 4639.072185562901, 4639.884002899887, 4643.95356046442, 4644.187267228222, 4647.790849411785, 4692.436907571045, 4701.271302948048, 4704.270838020112, 4713.316569097462, 4715.646326525456, 5429.511343979061, 5461.808836690776, 5470.425605311465, 5476.151196564539, 5487.396386397493, 6391.169148010729, 6587.83530411734, 6594.340565943463, 6605.207375115017, 6632.568883022588, 1644.1450445768373, 1667.6748034133227, 1669.5325308913523, 1670.0397271568897, 1675.8826882118378, 1084.078533246734, 1094.4691824465128, 1095.90684791792, 1112.7329440934118, 1116.0346300450053, 6122.908156377658, 6169.0, 6194.566380353332, 6216.222972128484, 6223.595466294767, 6784.185897692309, 6841.692123854438, 6848.657567121624, 6848.863022739617, 6923.58458492482, 6133.233345831771, 6211.223597050369, 6212.0, 6234.625922444668, 6246.9062964054665, 3678.4850120983083, 3709.9072523187137, 3720.3489389356755, 3736.3274610569815, 3737.588865224823, 7005.719771209197, 7035.261297563785, 7040.331168538981, 7049.259827718119, 7050.717971281194, 6909.343612356818, 7042.61265630385, 7055.400290975222, 7067.858642827115, 7071.858562828715, 7177.497575169792, 7274.1634712007735, 7277.3086556777025, 7281.5995120267835, 7290.671919763623, 6819.761308354382, 6886.896696549456, 6889.862202755817, 6901.654917254217, 6910.136232970879, 6697.598144111369, 6767.864642707217, 6799.864002720017, 6816.216135144522, 6818.897716534157, 7119.181294151032, 7167.319104685047, 7172.928270717226, 7179.82050448722, 7181.640917954186, 4610.6542009350105, 4643.024964757439, 4649.721016738871, 4652.232381657124, 4656.231721766007, 6729.5625784323865, 6877.346652068046, 6910.930890691029, 6912.412444942236, 6920.688569014507, 6687.699053542699, 6715.899261511179, 6716.429103526059, 6725.49558783103, 6734.3602357775935, 6656.83357916056, 6686.83282917931, 6691.1636045494315, 6695.665216739241, 6698.464122870061, 6396.42432181106, 6546.116274302908, 6547.934520654732, 6558.967205163944, 6602.570832895846, 6695.464362850863, 6710.060591517094, 6761.154855643044, 6776.322367763184, 6781.38967492928, 6356.396142366468, 6525.282218956006, 6552.27924928267, 6560.475161987125, 6570.5400621956005], "unit": "score", "name": "prototype.html", "value": 4970.95674690246}, {"lowerIsBetter": false, "replicates": [837.9539125348111, 860.4321148042292, 877.736678996301, 879.1340529578364, 901.9807617392346, 13448.731025379486, 13464.596062118153, 13475.528356507511, 13522.256275904821, 13609.38757755901, 12907.483700651963, 13080.345982700874, 13080.934595327033, 13082.0, 13082.084254102192, 659.5646873063766, 675.3010633993817, 806.6249194124761, 819.901611806584, 822.7326119011316, 792.1444839573276, 801.5831767480906, 802.0575823407502, 804.6781287485023, 812.3176531713359, 853.5390888920007, 861.7371701631, 861.9094995025526, 863.7020228021354, 865.6277800545763, 851.4763420496412, 852.9360297977677, 860.0195776814468, 862.2153840005565, 862.2455351567379, 630.6058713304185, 633.0346222011424, 633.2559242889632, 635.7584118035163, 637.101686621861, 12956.157849739737, 12986.0, 13117.212967221998, 13145.539906103337, 13157.0, 12783.488660453571, 13085.084044116915, 13231.338433078405, 13343.933280333633, 13392.665183370495, 10494.842577361345, 10503.548968776116, 10687.14502839771, 10747.946260268727, 11035.83446248307, 3579.2662504186837, 3623.9852841204506, 3642.7996460194677, 3693.9445908311395, 3725.497057897176, 43252.3512147318, 43599.12801743979, 43639.563604363866, 43749.0, 43818.56181438208, 9719.951400242953, 9896.752581185385, 9995.600175992879, 10093.798124037477, 10239.18086553074, 17979.640407191782, 17985.1007449627, 18102.094895255184, 18133.909330453527, 18340.082995850422, 7649.732259370895, 7661.846763064707, 7692.653830577638, 7840.803979900434, 8040.0, 4092.7339722917914, 4196.538380778112, 4292.678049146264, 4313.956860431418, 4324.891877703082, 2850.102217801386, 2864.971350286512, 2866.756325712296, 2872.6983666715114, 2883.480973424804, 485.95869351104847, 501.81182056728727, 509.8648858052619, 511.8797082685566, 524.9790008399622, 638.3999040901538, 644.2326781814517, 646.731606383355, 675.6656346749226, 717.9959495125022, 7803.102643196105, 8057.59712014397, 8058.677652893936, 8649.394542382099, 8782.473051616924, 626.8777588370224, 648.9221293444817, 669.5413641655482, 675.4292622733782, 681.7239018197638, 3777.735558510878, 3804.7336686431686, 3916.4516967624554, 3920.4511368408444, 3934.6852251819787, 56320.43679563234, 56872.0, 56998.0, 57339.42660573425, 57419.42580574224, 46703.5329646706, 47297.763511182224, 47304.5269547307, 47362.763186183845, 47489.76255118702, 42221.0, 42326.36510452346, 42368.15263694709, 43257.78371108124, 43534.564654353686, 8104.432689711899, 8140.796480087808, 8173.141820109041, 8406.411551191602, 8469.280111190617, 33872.15319617029, 34094.14764630805, 34149.21557466287, 34183.145421364665, 34634.48048279227, 40846.387304191056, 41053.0, 41127.38308925309, 42798.35802462903, 43292.35061474017, 11460.598879039528, 11534.480948357177, 11628.94185529067, 11698.122640801803, 11720.120990925545, 12252.509899603916, 12301.692457688629, 12308.199967002116, 12349.135560510678, 12419.93790031044, 10682.359058456517, 10768.300060496043, 10861.619843305447, 11057.778844422906, 11111.166662500184, 10457.372557646566, 10463.529141188817, 10741.516631751747, 10768.946155269174, 11311.151663625096, 10088.092071713581, 10215.336003159771, 10233.641822536176, 10359.171266298526, 10398.220133489867, 9055.592498337723, 9203.171714545722, 9270.768230794283, 9704.466254356079, 9795.853062204214, 9080.40977336471, 9410.529473526432, 9425.811483770423, 9481.0, 9485.525723713925], "unit": "score", "name": "yui.html", "value": 6194.312954424006}], "name": "dromaeo_css", "value": 6750.783811239495}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 109.0, 114.0, 120.0, 111.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 155.0, 166.0, 134.0, 168.0, 156.0, 127.0, 176.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 166.0, 172.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 81.0, 75.0, 71.0, 73.0, 132.0, 73.0, 72.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 149.0, 96.0, 97.0, 96.0, 149.0, 96.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 111.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 148.0, 147.0, 147.0, 147.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 59.0, 60.0, 60.0, 70.0, 59.0, 58.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 86.0, 86.0, 87.0, 88.0, 88.0, 90.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [123.0, 118.0, 119.0, 120.0, 120.0, 127.0, 133.0, 119.0, 122.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [143.0, 154.0, 155.0, 154.0, 155.0, 159.0, 155.0, 155.0, 156.0, 162.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1529.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.23463317911435], "unit": "score", "name": "Richards", "value": 213.64770399999995}, {"lowerIsBetter": false, "replicates": [187.79342723004694], "unit": "score", "name": "DeltaBlue", "value": 352.0783499999999}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [753.5795026375282], "unit": "score", "name": "Earley", "value": 884.3964010000001}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [41061.22448979592], "unit": "score", "name": "RegExp", "value": 22.18601640159044}, {"lowerIsBetter": false, "replicates": [605.3268765133172], "unit": "score", "name": "Splay", "value": 134.62313200000003}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20291.305705183826}]} 01:13:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20291.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1529.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6750.78"}}} 01:13:51 INFO - Return code: 0 01:13:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:13:51 INFO - # TBPL SUCCESS # 01:13:51 INFO - Running post-action listener: _resource_record_post_action 01:13:51 INFO - Running post-run listener: _resource_record_post_run 01:13:52 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562679808; Read time: 136; Write time: 870864 01:13:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 245903360; Read time: 136; Write time: 405736 01:13:52 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 316776448; Read time: 0; Write time: 465128 01:13:52 INFO - Running post-run listener: _upload_blobber_files 01:13:52 INFO - Blob upload gear active. 01:13:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:13:52 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 01:13:52 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'] 01:13:52 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 01:13:52 INFO - (blobuploader) - INFO - Open directory for files ... 01:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:13:53 INFO - (blobuploader) - INFO - Done attempting. 01:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:13:54 INFO - (blobuploader) - INFO - Done attempting. 01:13:54 INFO - (blobuploader) - INFO - Iteration through files over. 01:13:54 INFO - Return code: 0 01:13:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:13:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:13:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f76aca516dda6c6b6857129acdda362401e543b985ed4ac7d6e93637643fa14338f7cc4fc21cc593f24c15bbc3e2794c859663838591d4a32b00c9a9764e18c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba658b35c93fd1aecf9ce956fe9103e3d46166799c3fdeb2c365c6218e7b1cc61eee8315efbcb856a631e3cb2dcb17d1fffa020ac4295dfe8d235a04ce9d516b"} 01:13:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:13:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:13:54 INFO - Contents: 01:13:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f76aca516dda6c6b6857129acdda362401e543b985ed4ac7d6e93637643fa14338f7cc4fc21cc593f24c15bbc3e2794c859663838591d4a32b00c9a9764e18c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba658b35c93fd1aecf9ce956fe9103e3d46166799c3fdeb2c365c6218e7b1cc61eee8315efbcb856a631e3cb2dcb17d1fffa020ac4295dfe8d235a04ce9d516b"} 01:13:54 INFO - Copying logs to upload dir... 01:13:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.339246 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-08 01:13:54.196204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 01:13:54.199909) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 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/4f76aca516dda6c6b6857129acdda362401e543b985ed4ac7d6e93637643fa14338f7cc4fc21cc593f24c15bbc3e2794c859663838591d4a32b00c9a9764e18c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba658b35c93fd1aecf9ce956fe9103e3d46166799c3fdeb2c365c6218e7b1cc61eee8315efbcb856a631e3cb2dcb17d1fffa020ac4295dfe8d235a04ce9d516b"} build_url:https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/V-3v1HhrTrSxEorZXCZLIA/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/4f76aca516dda6c6b6857129acdda362401e543b985ed4ac7d6e93637643fa14338f7cc4fc21cc593f24c15bbc3e2794c859663838591d4a32b00c9a9764e18c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba658b35c93fd1aecf9ce956fe9103e3d46166799c3fdeb2c365c6218e7b1cc61eee8315efbcb856a631e3cb2dcb17d1fffa020ac4295dfe8d235a04ce9d516b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 01:13:54.223973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:13:54.224266) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452233675.586401-40503476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:13:54.309055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 01:13:54.309332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 01:13:54.309604) ========= ========= Total master_lag: 0.23 =========