builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1457921844.85 results: success (0) buildid: 20160313163010 builduid: 7a00a44ac90a42e383faf3ea9fbbda11 revision: f0c0480732d36153e8839c7f17394d45f679f87d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.846686) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.847110) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.847394) ========= 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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005407 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.869910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.870206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.886697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.886973) ========= 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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.939243) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.939517) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.939865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:24.940169) ========= 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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-13 19:17:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 56.7M=0s 2016-03-13 19:17:25 (56.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.129380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.129694) ========= 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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017978 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.182924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.183219) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0c0480732d36153e8839c7f17394d45f679f87d --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 f0c0480732d36153e8839c7f17394d45f679f87d --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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-13 19:17:25,398 truncating revision to first 12 chars 2016-03-13 19:17:25,398 Setting DEBUG logging. 2016-03-13 19:17:25,398 attempt 1/10 2016-03-13 19:17:25,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0c0480732d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-13 19:17:25,659 unpacking tar archive at: mozilla-central-f0c0480732d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.744791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.745122) ========= echo f0c0480732d36153e8839c7f17394d45f679f87d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f0c0480732d36153e8839c7f17394d45f679f87d'] 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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f0c0480732d36153e8839c7f17394d45f679f87d program finished with exit code 0 elapsedTime=0.004733 script_repo_revision: 'f0c0480732d36153e8839c7f17394d45f679f87d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.795028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.795323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 19:17:25.808358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-13 19:17:25.808618) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:17:26 INFO - MultiFileLogger online at 20160313 19:17:26 in /builds/slave/test-pgo 19:17:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:17:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:17:26 INFO - {'append_to_log': False, 19:17:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:17:26 INFO - 'blob_upload_branch': 'Firefox', 19:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:17:26 INFO - 'branch': 'Firefox', 19:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:26 INFO - 'config_files': ('talos/linux_config.py',), 19:17:26 INFO - 'default_actions': ('clobber', 19:17:26 INFO - 'read-buildbot-config', 19:17:26 INFO - 'download-and-extract', 19:17:26 INFO - 'populate-webroot', 19:17:26 INFO - 'create-virtualenv', 19:17:26 INFO - 'install', 19:17:26 INFO - 'run-tests'), 19:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:26 INFO - 'download_minidump_stackwalk': True, 19:17:26 INFO - 'download_symbols': 'ondemand', 19:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:26 INFO - 'installer_path': 'installer.exe', 19:17:26 INFO - 'log_level': 'info', 19:17:26 INFO - 'log_name': 'talos', 19:17:26 INFO - 'log_to_console': True, 19:17:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:17:26 INFO - 'opt_config_files': (), 19:17:26 INFO - 'pip_index': False, 19:17:26 INFO - 'sps_profile': False, 19:17:26 INFO - 'sps_profile_interval': 0, 19:17:26 INFO - 'suite': 'dromaeojs', 19:17:26 INFO - 'system_bits': '32', 19:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:26 INFO - 'title': 'talos-linux64-ix-009', 19:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:26 INFO - 'use_talos_json': True, 19:17:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:26 INFO - 'work_dir': 'build'} 19:17:26 INFO - ##### 19:17:26 INFO - ##### Running clobber step. 19:17:26 INFO - ##### 19:17:26 INFO - Running pre-action listener: _resource_record_pre_action 19:17:26 INFO - Running main action method: clobber 19:17:26 INFO - rmtree: /builds/slave/test-pgo/build 19:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:17:27 INFO - Running post-action listener: _resource_record_post_action 19:17:27 INFO - ##### 19:17:27 INFO - ##### Running read-buildbot-config step. 19:17:27 INFO - ##### 19:17:27 INFO - Running pre-action listener: _resource_record_pre_action 19:17:27 INFO - Running main action method: read_buildbot_config 19:17:27 INFO - Using buildbot properties: 19:17:27 INFO - { 19:17:27 INFO - "project": "", 19:17:27 INFO - "product": "firefox", 19:17:27 INFO - "script_repo_revision": "production", 19:17:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:17:27 INFO - "repository": "", 19:17:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:17:27 INFO - "buildid": "20160313163010", 19:17:27 INFO - "pgo_build": "True", 19:17:27 INFO - "basedir": "/builds/slave/test-pgo", 19:17:27 INFO - "buildnumber": 709, 19:17:27 INFO - "slavename": "talos-linux64-ix-009", 19:17:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:17:27 INFO - "platform": "ubuntu64_hw", 19:17:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:17:27 INFO - "branch": "mozilla-central", 19:17:27 INFO - "repo_path": "mozilla-central", 19:17:27 INFO - "revision": "f0c0480732d36153e8839c7f17394d45f679f87d", 19:17:27 INFO - "stage_platform": "linux64-pgo", 19:17:27 INFO - "builduid": "7a00a44ac90a42e383faf3ea9fbbda11", 19:17:27 INFO - "slavebuilddir": "test" 19:17:27 INFO - } 19:17:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:17:27 INFO - Running post-action listener: _resource_record_post_action 19:17:27 INFO - ##### 19:17:27 INFO - ##### Running download-and-extract step. 19:17:27 INFO - ##### 19:17:27 INFO - Running pre-action listener: _resource_record_pre_action 19:17:27 INFO - Running main action method: download_and_extract 19:17:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:27 INFO - https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:17:28 INFO - Downloaded 1361 bytes. 19:17:28 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:17:28 INFO - Using the following test package requirements: 19:17:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:17:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:17:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'jsshell-linux-x86_64.zip'], 19:17:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:17:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:17:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:17:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:17:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:17:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:28 INFO - https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:17:29 INFO - Downloaded 23558729 bytes. 19:17:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:17:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:17:31 INFO - Return code: 0 19:17:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:31 INFO - https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:17:38 INFO - Downloaded 23558729 bytes. 19:17:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:17:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:17:39 INFO - Return code: 0 19:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:39 INFO - https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:17:40 INFO - Downloaded 10845263 bytes. 19:17:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:17:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:17:40 INFO - Return code: 0 19:17: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')]} 19:17:40 INFO - https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:17:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:17:42 INFO - Downloaded 57668674 bytes. 19:17:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:42 INFO - mkdir: /builds/slave/test-pgo/properties 19:17:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:17:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:17:42 INFO - Contents: 19:17:42 INFO - build_url:https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:43 INFO - Running post-action listener: _resource_record_post_action 19:17:43 INFO - Running post-action listener: set_extra_try_arguments 19:17:43 INFO - ##### 19:17:43 INFO - ##### Running populate-webroot step. 19:17:43 INFO - ##### 19:17:43 INFO - Running pre-action listener: _resource_record_pre_action 19:17:43 INFO - Running main action method: populate_webroot 19:17:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:43 INFO - '--tppagecycles', 19:17:43 INFO - '7'], 19:17:43 INFO - 'tests': ['tsvgm']}}, 19:17:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:17:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:17:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'tests': ['damp', 'tps']}, 19:17:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['damp', 'tps']}, 19:17:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:17:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:43 INFO - 'other': {'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other_l64': {'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other_nol64': {'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'svgr': {'tests': ['tsvgx', 19:17:43 INFO - 'tsvgr_opacity', 19:17:43 INFO - 'tart', 19:17:43 INFO - 'tscrollx', 19:17:43 INFO - 'cart']}, 19:17:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['tsvgx', 19:17:43 INFO - 'tsvgr_opacity', 19:17:43 INFO - 'tart', 19:17:43 INFO - 'tscrollx', 19:17:43 INFO - 'cart']}, 19:17:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'tests': ['tp5o']}, 19:17:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'talos_options': ['--e10s'], 19:17:43 INFO - 'tests': ['tp5o']}, 19:17:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'talos_options': ['--xperf_path', 19:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:43 INFO - 'tests': ['tp5n']}, 19:17:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:43 INFO - 'talos_options': ['--e10s', 19:17:43 INFO - '--xperf_path', 19:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:43 INFO - 'tests': ['tp5n']}}, 19:17:43 INFO - 'talos.zip': {'path': '', 19:17:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:43 INFO - Running post-action listener: _resource_record_post_action 19:17:43 INFO - ##### 19:17:43 INFO - ##### Running create-virtualenv step. 19:17:43 INFO - ##### 19:17:43 INFO - Running pre-action listener: _resource_record_pre_action 19:17:43 INFO - Running main action method: create_virtualenv 19:17:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:17:43 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 19:17:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:17:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:43 INFO - Using real prefix '/usr' 19:17:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:17:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:45 INFO - Installing pip.................done. 19:17:45 INFO - Return code: 0 19:17:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:17: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')]} 19:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:17:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:17:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:17:45 INFO - Using env: {'DISPLAY': ':0', 19:17:45 INFO - 'HOME': '/home/cltbld', 19:17:45 INFO - 'LANG': 'en_US.UTF-8', 19:17:45 INFO - 'LANGUAGE': 'en_US:en', 19:17:45 INFO - 'LOGNAME': 'cltbld', 19:17:45 INFO - 'MAIL': '/var/mail/cltbld', 19:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:45 INFO - 'MOZ_NO_REMOTE': '1', 19:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:45 INFO - 'NO_EM_RESTART': '1', 19:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:45 INFO - 'SHELL': '/bin/bash', 19:17:45 INFO - 'SHLVL': '1', 19:17:45 INFO - 'TERM': 'linux', 19:17:45 INFO - 'TMOUT': '86400', 19:17:45 INFO - 'USER': 'cltbld', 19:17:45 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:45 INFO - '_': '/tools/buildbot/bin/python'} 19:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:45 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 19:17:45 INFO - Cleaning up... 19:17:45 INFO - Return code: 0 19:17:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:17: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')]} 19:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:17:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:17:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:17:45 INFO - Using env: {'DISPLAY': ':0', 19:17:45 INFO - 'HOME': '/home/cltbld', 19:17:45 INFO - 'LANG': 'en_US.UTF-8', 19:17:45 INFO - 'LANGUAGE': 'en_US:en', 19:17:45 INFO - 'LOGNAME': 'cltbld', 19:17:45 INFO - 'MAIL': '/var/mail/cltbld', 19:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:45 INFO - 'MOZ_NO_REMOTE': '1', 19:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:45 INFO - 'NO_EM_RESTART': '1', 19:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:45 INFO - 'SHELL': '/bin/bash', 19:17:45 INFO - 'SHLVL': '1', 19:17:45 INFO - 'TERM': 'linux', 19:17:45 INFO - 'TMOUT': '86400', 19:17:45 INFO - 'USER': 'cltbld', 19:17:45 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:45 INFO - '_': '/tools/buildbot/bin/python'} 19:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:46 INFO - Downloading/unpacking psutil>=0.7.1 19:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:48 INFO - Installing collected packages: psutil 19:17:48 INFO - Running setup.py install for psutil 19:17:48 INFO - building 'psutil._psutil_linux' extension 19:17:48 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 19:17:48 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 19:17:48 INFO - building 'psutil._psutil_posix' extension 19:17:48 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 19:17:48 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 19:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:48 INFO - Successfully installed psutil 19:17:48 INFO - Cleaning up... 19:17:48 INFO - Return code: 0 19:17:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:17: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')]} 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:17:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:17:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:17:48 INFO - Using env: {'DISPLAY': ':0', 19:17:48 INFO - 'HOME': '/home/cltbld', 19:17:48 INFO - 'LANG': 'en_US.UTF-8', 19:17:48 INFO - 'LANGUAGE': 'en_US:en', 19:17:48 INFO - 'LOGNAME': 'cltbld', 19:17:48 INFO - 'MAIL': '/var/mail/cltbld', 19:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:48 INFO - 'MOZ_NO_REMOTE': '1', 19:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:48 INFO - 'NO_EM_RESTART': '1', 19:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:48 INFO - 'SHELL': '/bin/bash', 19:17:48 INFO - 'SHLVL': '1', 19:17:48 INFO - 'TERM': 'linux', 19:17:48 INFO - 'TMOUT': '86400', 19:17:48 INFO - 'USER': 'cltbld', 19:17:48 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:48 INFO - '_': '/tools/buildbot/bin/python'} 19:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:17:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:17:50 INFO - Installing collected packages: mozsystemmonitor 19:17:50 INFO - Running setup.py install for mozsystemmonitor 19:17:50 INFO - Successfully installed mozsystemmonitor 19:17:50 INFO - Cleaning up... 19:17:50 INFO - Return code: 0 19:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:17:50 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')]} 19:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:50 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')]} 19:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:17:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:17:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:17:50 INFO - Using env: {'DISPLAY': ':0', 19:17:50 INFO - 'HOME': '/home/cltbld', 19:17:50 INFO - 'LANG': 'en_US.UTF-8', 19:17:50 INFO - 'LANGUAGE': 'en_US:en', 19:17:50 INFO - 'LOGNAME': 'cltbld', 19:17:50 INFO - 'MAIL': '/var/mail/cltbld', 19:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:50 INFO - 'MOZ_NO_REMOTE': '1', 19:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:50 INFO - 'NO_EM_RESTART': '1', 19:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:50 INFO - 'SHELL': '/bin/bash', 19:17:50 INFO - 'SHLVL': '1', 19:17:50 INFO - 'TERM': 'linux', 19:17:50 INFO - 'TMOUT': '86400', 19:17:50 INFO - 'USER': 'cltbld', 19:17:50 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:50 INFO - '_': '/tools/buildbot/bin/python'} 19:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:51 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:53 INFO - Downloading blobuploader-1.2.4.tar.gz 19:17:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:17:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:17:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:17:54 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 19:17:54 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 19:17:54 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 19:17:54 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 19:17:54 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 19:17:54 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 19:17:54 INFO - Downloading docopt-0.6.1.tar.gz 19:17:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:17:54 INFO - Installing collected packages: blobuploader, requests, docopt 19:17:54 INFO - Running setup.py install for blobuploader 19:17:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:17:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:17:54 INFO - Running setup.py install for requests 19:17:55 INFO - Running setup.py install for docopt 19:17:55 INFO - Successfully installed blobuploader requests docopt 19:17:55 INFO - Cleaning up... 19:17:55 INFO - Return code: 0 19:17:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:17:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 19:17:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 19:17:55 INFO - Using env: {'DISPLAY': ':0', 19:17:55 INFO - 'HOME': '/home/cltbld', 19:17:55 INFO - 'LANG': 'en_US.UTF-8', 19:17:55 INFO - 'LANGUAGE': 'en_US:en', 19:17:55 INFO - 'LOGNAME': 'cltbld', 19:17:55 INFO - 'MAIL': '/var/mail/cltbld', 19:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:55 INFO - 'MOZ_NO_REMOTE': '1', 19:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:55 INFO - 'NO_EM_RESTART': '1', 19:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:55 INFO - 'SHELL': '/bin/bash', 19:17:55 INFO - 'SHLVL': '1', 19:17:55 INFO - 'TERM': 'linux', 19:17:55 INFO - 'TMOUT': '86400', 19:17:55 INFO - 'USER': 'cltbld', 19:17:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:55 INFO - '_': '/tools/buildbot/bin/python'} 19:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:55 INFO - Running setup.py (path:/tmp/pip-7PbtIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:55 INFO - Running setup.py (path:/tmp/pip-C1uncg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:55 INFO - Running setup.py (path:/tmp/pip-Vqaad0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:55 INFO - Running setup.py (path:/tmp/pip-jtFCpO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:55 INFO - Running setup.py (path:/tmp/pip-RKgdlJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:55 INFO - Running setup.py (path:/tmp/pip-_nrhCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:55 INFO - Running setup.py (path:/tmp/pip-a0LxY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:55 INFO - Running setup.py (path:/tmp/pip-1L1aei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:55 INFO - Running setup.py (path:/tmp/pip-9fe382-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:56 INFO - Running setup.py (path:/tmp/pip-OYqB1d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:56 INFO - Running setup.py (path:/tmp/pip-vQkZ2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:56 INFO - Running setup.py (path:/tmp/pip-f1_zO0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:56 INFO - Running setup.py (path:/tmp/pip-UJTsms-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:56 INFO - Running setup.py (path:/tmp/pip-Gfm3rX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:56 INFO - Running setup.py (path:/tmp/pip-82kyTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:56 INFO - Running setup.py (path:/tmp/pip-yC7cPw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:56 INFO - Running setup.py (path:/tmp/pip-BJH5Wa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:17:56 INFO - Running setup.py install for manifestparser 19:17:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:17:56 INFO - Running setup.py install for mozcrash 19:17:56 INFO - Running setup.py install for mozdebug 19:17:56 INFO - Running setup.py install for mozdevice 19:17:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Running setup.py install for mozfile 19:17:57 INFO - Running setup.py install for mozhttpd 19:17:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Running setup.py install for mozinfo 19:17:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Running setup.py install for mozInstall 19:17:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Running setup.py install for mozleak 19:17:57 INFO - Running setup.py install for mozlog 19:17:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Running setup.py install for moznetwork 19:17:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Running setup.py install for mozprocess 19:17:57 INFO - Running setup.py install for mozprofile 19:17:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:17:57 INFO - Running setup.py install for mozrunner 19:17:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:17:58 INFO - Running setup.py install for mozscreenshot 19:17:58 INFO - Running setup.py install for moztest 19:17:58 INFO - Running setup.py install for mozversion 19:17:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:17:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:17:58 INFO - Cleaning up... 19:17:58 INFO - Return code: 0 19:17:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:17: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')]} 19:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:17:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:17:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:17:58 INFO - Using env: {'DISPLAY': ':0', 19:17:58 INFO - 'HOME': '/home/cltbld', 19:17:58 INFO - 'LANG': 'en_US.UTF-8', 19:17:58 INFO - 'LANGUAGE': 'en_US:en', 19:17:58 INFO - 'LOGNAME': 'cltbld', 19:17:58 INFO - 'MAIL': '/var/mail/cltbld', 19:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:58 INFO - 'MOZ_NO_REMOTE': '1', 19:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:58 INFO - 'NO_EM_RESTART': '1', 19:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:58 INFO - 'SHELL': '/bin/bash', 19:17:58 INFO - 'SHLVL': '1', 19:17:58 INFO - 'TERM': 'linux', 19:17:58 INFO - 'TMOUT': '86400', 19:17:58 INFO - 'USER': 'cltbld', 19:17:58 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:58 INFO - '_': '/tools/buildbot/bin/python'} 19:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:58 INFO - Running setup.py (path:/tmp/pip-_vZa_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:58 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)) 19:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:58 INFO - Running setup.py (path:/tmp/pip-h76_8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:58 INFO - Running setup.py (path:/tmp/pip-m8MsSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:58 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)) 19:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:58 INFO - Running setup.py (path:/tmp/pip-QfIR8u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:58 INFO - Running setup.py (path:/tmp/pip-o8tPEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:59 INFO - Running setup.py (path:/tmp/pip-eVMW_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:59 INFO - Running setup.py (path:/tmp/pip-XTUgSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:59 INFO - Running setup.py (path:/tmp/pip-K8LWJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:59 INFO - Running setup.py (path:/tmp/pip-r0XsYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:59 INFO - Running setup.py (path:/tmp/pip-Pwmz_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:59 INFO - Running setup.py (path:/tmp/pip-7kzyBW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:59 INFO - Running setup.py (path:/tmp/pip-ZWe6Xk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:59 INFO - Running setup.py (path:/tmp/pip-4fS3FE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:59 INFO - Running setup.py (path:/tmp/pip-Ju4Oor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:59 INFO - Running setup.py (path:/tmp/pip-lRXleE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:59 INFO - Running setup.py (path:/tmp/pip-cjnj5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:59 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)) 19:17:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:59 INFO - Running setup.py (path:/tmp/pip-WbpGVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:59 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)) 19:17:59 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:17:59 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:17:59 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)) 19:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:17:59 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:17:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:01 INFO - Downloading blessings-1.6.tar.gz 19:18:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:01 INFO - Installing collected packages: blessings 19:18:01 INFO - Running setup.py install for blessings 19:18:01 INFO - Successfully installed blessings 19:18:01 INFO - Cleaning up... 19:18:01 INFO - Return code: 0 19:18:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:18:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:18:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:18:02 INFO - Reading from file tmpfile_stdout 19:18:02 INFO - Current package versions: 19:18:02 INFO - argparse == 1.2.1 19:18:02 INFO - blessings == 1.6 19:18:02 INFO - blobuploader == 1.2.4 19:18:02 INFO - docopt == 0.6.1 19:18:02 INFO - manifestparser == 1.1 19:18:02 INFO - mozInstall == 1.12 19:18:02 INFO - mozcrash == 0.17 19:18:02 INFO - mozdebug == 0.1 19:18:02 INFO - mozdevice == 0.48 19:18:02 INFO - mozfile == 1.2 19:18:02 INFO - mozhttpd == 0.7 19:18:02 INFO - mozinfo == 0.9 19:18:02 INFO - mozleak == 0.1 19:18:02 INFO - mozlog == 3.1 19:18:02 INFO - moznetwork == 0.27 19:18:02 INFO - mozprocess == 0.22 19:18:02 INFO - mozprofile == 0.28 19:18:02 INFO - mozrunner == 6.11 19:18:02 INFO - mozscreenshot == 0.1 19:18:02 INFO - mozsystemmonitor == 0.0 19:18:02 INFO - moztest == 0.7 19:18:02 INFO - mozversion == 1.4 19:18:02 INFO - psutil == 3.1.1 19:18:02 INFO - requests == 1.2.3 19:18:02 INFO - wsgiref == 0.1.2 19:18:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:18: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')]} 19:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:18:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:18:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:18:02 INFO - Using env: {'DISPLAY': ':0', 19:18:02 INFO - 'HOME': '/home/cltbld', 19:18:02 INFO - 'LANG': 'en_US.UTF-8', 19:18:02 INFO - 'LANGUAGE': 'en_US:en', 19:18:02 INFO - 'LOGNAME': 'cltbld', 19:18:02 INFO - 'MAIL': '/var/mail/cltbld', 19:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:02 INFO - 'MOZ_NO_REMOTE': '1', 19:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:02 INFO - 'NO_EM_RESTART': '1', 19:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:18:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:18:02 INFO - 'SHELL': '/bin/bash', 19:18:02 INFO - 'SHLVL': '1', 19:18:02 INFO - 'TERM': 'linux', 19:18:02 INFO - 'TMOUT': '86400', 19:18:02 INFO - 'USER': 'cltbld', 19:18:02 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:02 INFO - '_': '/tools/buildbot/bin/python'} 19:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 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)) 19:18:02 INFO - Cleaning up... 19:18:02 INFO - Return code: 0 19:18:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:18: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')]} 19:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:18:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:18:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:18:02 INFO - Using env: {'DISPLAY': ':0', 19:18:02 INFO - 'HOME': '/home/cltbld', 19:18:02 INFO - 'LANG': 'en_US.UTF-8', 19:18:02 INFO - 'LANGUAGE': 'en_US:en', 19:18:02 INFO - 'LOGNAME': 'cltbld', 19:18:02 INFO - 'MAIL': '/var/mail/cltbld', 19:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:02 INFO - 'MOZ_NO_REMOTE': '1', 19:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:02 INFO - 'NO_EM_RESTART': '1', 19:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:18:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:18:02 INFO - 'SHELL': '/bin/bash', 19:18:02 INFO - 'SHLVL': '1', 19:18:02 INFO - 'TERM': 'linux', 19:18:02 INFO - 'TMOUT': '86400', 19:18:02 INFO - 'USER': 'cltbld', 19:18:02 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:02 INFO - '_': '/tools/buildbot/bin/python'} 19:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:02 INFO - Downloading/unpacking jsonschema 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:18:04 INFO - Downloading/unpacking functools32 (from jsonschema) 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:04 INFO - Downloading functools32-3.2.3-2.tar.gz 19:18:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:18:04 INFO - warning: no files found matching '*.txt' 19:18:04 INFO - no previously-included directories found matching 'build' 19:18:04 INFO - no previously-included directories found matching 'dist' 19:18:04 INFO - no previously-included directories found matching '.git*' 19:18:04 INFO - Installing collected packages: jsonschema, functools32 19:18:04 INFO - Running setup.py install for functools32 19:18:04 INFO - warning: no files found matching '*.txt' 19:18:04 INFO - no previously-included directories found matching 'build' 19:18:04 INFO - no previously-included directories found matching 'dist' 19:18:04 INFO - no previously-included directories found matching '.git*' 19:18:04 INFO - Successfully installed jsonschema functools32 19:18:04 INFO - Cleaning up... 19:18:04 INFO - Return code: 0 19:18:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6f552e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', '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 19:18:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:18:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:18:04 INFO - Using env: {'DISPLAY': ':0', 19:18:04 INFO - 'HOME': '/home/cltbld', 19:18:04 INFO - 'LANG': 'en_US.UTF-8', 19:18:04 INFO - 'LANGUAGE': 'en_US:en', 19:18:04 INFO - 'LOGNAME': 'cltbld', 19:18:04 INFO - 'MAIL': '/var/mail/cltbld', 19:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:04 INFO - 'MOZ_NO_REMOTE': '1', 19:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:04 INFO - 'NO_EM_RESTART': '1', 19:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:18:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:18:04 INFO - 'SHELL': '/bin/bash', 19:18:04 INFO - 'SHLVL': '1', 19:18:04 INFO - 'TERM': 'linux', 19:18:04 INFO - 'TMOUT': '86400', 19:18:04 INFO - 'USER': 'cltbld', 19:18:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:04 INFO - '_': '/tools/buildbot/bin/python'} 19:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:05 INFO - Downloading/unpacking flake8 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:18:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:18:06 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 19:18:06 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 19:18:06 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 19:18:06 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 19:18:06 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 19:18:06 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 19:18:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:18:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 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 19:18:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:18:07 INFO - no previously-included directories found matching 'docs/_build' 19:18:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:18:07 INFO - Running setup.py install for pep8 19:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:18:07 INFO - no previously-included directories found matching 'docs/_build' 19:18:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:18:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:18:07 INFO - Cleaning up... 19:18:07 INFO - Return code: 0 19:18:07 INFO - Running post-action listener: _resource_record_post_action 19:18:07 INFO - Running post-action listener: _start_resource_monitoring 19:18:07 INFO - Starting resource monitoring. 19:18:07 INFO - ##### 19:18:07 INFO - ##### Running install step. 19:18:07 INFO - ##### 19:18:07 INFO - Running pre-action listener: _resource_record_pre_action 19:18:07 INFO - Running main action method: install 19:18:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:18:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:18:08 INFO - Reading from file tmpfile_stdout 19:18:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:18:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:18:08 INFO - Reading from file tmpfile_stdout 19:18:08 INFO - Output received: 19:18:08 INFO - Usage: mozinstall [options] installer 19:18:08 INFO - Options: 19:18:08 INFO - -h, --help show this help message and exit 19:18:08 INFO - -d DEST, --destination=DEST 19:18:08 INFO - Directory to install application into. [default: 19:18:08 INFO - "/builds/slave/test-pgo"] 19:18:08 INFO - --app=APP Application being installed. [default: firefox] 19:18:08 INFO - mkdir: /builds/slave/test-pgo/build/application 19:18:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:18:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:18:24 INFO - Reading from file tmpfile_stdout 19:18:24 INFO - Output received: 19:18:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:18:24 INFO - Running post-action listener: _resource_record_post_action 19:18:24 INFO - ##### 19:18:24 INFO - ##### Running run-tests step. 19:18:24 INFO - ##### 19:18:24 INFO - Running pre-action listener: _resource_record_pre_action 19:18:24 INFO - Running main action method: run_tests 19:18:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:18:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:18:24 INFO - Python 2.7.3 19:18:24 INFO - Return code: 0 19:18:24 INFO - grabbing minidump binary from tooltool 19:18:24 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')]} 19:18:24 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 0x1b1f920>, '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 0x1b20820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b20cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:18:24 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 19:18:24 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 19:18:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:18:24 INFO - Return code: 0 19:18:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:18:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:18:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:18:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:18:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:18:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:18:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:18:25 INFO - Return code: 0 19:18:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:18:25 INFO - Using env: {'DISPLAY': ':0', 19:18:25 INFO - 'HOME': '/home/cltbld', 19:18:25 INFO - 'LANG': 'en_US.UTF-8', 19:18:25 INFO - 'LANGUAGE': 'en_US:en', 19:18:25 INFO - 'LOGNAME': 'cltbld', 19:18:25 INFO - 'MAIL': '/var/mail/cltbld', 19:18:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:18:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:25 INFO - 'MOZ_NO_REMOTE': '1', 19:18:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:25 INFO - 'NO_EM_RESTART': '1', 19:18:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:18:25 INFO - 'PWD': '/builds/slave/test-pgo', 19:18:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:18:25 INFO - 'SHELL': '/bin/bash', 19:18:25 INFO - 'SHLVL': '1', 19:18:25 INFO - 'TERM': 'linux', 19:18:25 INFO - 'TMOUT': '86400', 19:18:25 INFO - 'USER': 'cltbld', 19:18:25 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461', 19:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:25 INFO - '_': '/tools/buildbot/bin/python'} 19:18:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:18:25 INFO - mozversion application_buildid: 20160313163010 19:18:25 INFO - mozversion application_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 19:18:25 INFO - mozversion application_display_name: Nightly 19:18:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:18:25 INFO - mozversion application_name: Firefox 19:18:25 INFO - mozversion application_remotingname: firefox 19:18:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:18:25 INFO - mozversion application_vendor: Mozilla 19:18:25 INFO - mozversion application_version: 48.0a1 19:18:25 INFO - mozversion platform_buildid: 20160313163010 19:18:25 INFO - mozversion platform_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 19:18:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:18:25 INFO - mozversion platform_version: 48.0a1 19:18:25 INFO - using testdate: 1457921905 19:18:25 INFO - actual date: 1457921905 19:18:25 INFO - starting webserver on 'localhost:50369' 19:18:25 INFO - SUITE-START | Running 2 tests 19:18:25 INFO - TEST-START | dromaeo_css 19:18:25 INFO - operating with platform_type : linux_ 19:18:25 INFO - Initialising browser for dromaeo_css test... 19:18:25 INFO - TEST-INFO | started process 14016 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpep5s0G/profile http://localhost:50369/getInfo.html) 19:18:30 INFO - PROCESS | 14016 | __metrics Screen width/height:1600/1200 19:18:30 INFO - PROCESS | 14016 | colorDepth:24 19:18:30 INFO - PROCESS | 14016 | Browser inner width/height: 1024/697 19:18:30 INFO - PROCESS | 14016 | __metrics 19:18:31 ERROR - PROCESS | 14016 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:18:31 INFO - PROCESS | 14016 | 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. 19:18:32 INFO - TEST-INFO | 14016: exit 0 19:18:32 INFO - Browser initialized. 19:18:32 INFO - Running cycle 1/1 for dromaeo_css test... 19:18:32 INFO - TEST-INFO | started process 14108 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpep5s0G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:44 INFO - PROCESS | 14108 | RSS: Main: 152342528 19:18:44 INFO - PROCESS | 14108 | 19:19:35 INFO - PROCESS | 14108 | 1457921975091 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] 19:21:42 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:50369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50369/tests/dromaeo/cssquery-ext.html) 19:21:43 INFO - PROCESS | 14108 | RSS: Main: 259223552 19:21:43 INFO - PROCESS | 14108 | 19:24:46 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:50369/tests/dromaeo/cssquery-ext.html (next: http://localhost:50369/tests/dromaeo/cssquery-jquery.html) 19:24:46 INFO - PROCESS | 14108 | RSS: Main: 240742400 19:24:46 INFO - PROCESS | 14108 | 19:27:48 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:50369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50369/tests/dromaeo/cssquery-mootools.html) 19:27:49 INFO - PROCESS | 14108 | RSS: Main: 232968192 19:27:49 INFO - PROCESS | 14108 | 19:30:51 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:50369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50369/tests/dromaeo/cssquery-prototype.html) 19:30:51 INFO - PROCESS | 14108 | RSS: Main: 215953408 19:30:51 INFO - PROCESS | 14108 | 19:33:54 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:50369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50369/tests/dromaeo/cssquery-yui.html) 19:33:54 INFO - PROCESS | 14108 | RSS: Main: 219201536 19:33:54 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:50369/tests/dromaeo/cssquery-yui.html (next: http://localhost:50369/tests/dromaeo/cssquery-dojo.html) 19:36:57 INFO - PROCESS | 14108 | RSS: Main: 271339520 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | __start_tp_report 19:36:57 INFO - PROCESS | 14108 | _x_x_mozilla_page_load 19:36:57 INFO - PROCESS | 14108 | _x_x_mozilla_page_load_details 19:36:57 INFO - PROCESS | 14108 | |i|pagename|runs| 19:36:57 INFO - PROCESS | 14108 | |0;dojo.html;3060.464418726723;3091.5208142737883;3140.513220450831;3148.307372378076;3171.08038668786;5268.262443257947;5292.311999440072;5323.201519772036;5353.812616558416;5381.865453363668;5282.788688452457;5307.20391941209;5309.548688361494;5327.174287985359;5368.516833484995;4796.808127674889;4858.902821943559;4867.977724677822;5001.399832020163;5006.499350065001;4852.563269305761;4915.82794602189;4948.960718249172;4949.455559888409;5058.544730974211;4878.512148785128;4894.926576101361;4916;4946.530079642428;4970.627202959774;4798.112349215371;4840.975795121037;4858.611311095139;4860.05228980349;4885.6335774817035;4793.9280910786365;4828.830990915336;4856.538628830255;4860.343853579792;4873;5280.762365693553;5287;5291.814786482493;5293.788248470057;5303.761330740126;5654.46282603152;5659.943400565983;5674.716264186774;5679.886402271973;5704.258446401983;5583.664980101166;5673.290838645169;5703.201551782754;5706.743196556124;5718.485336319751;5275.63070585063;5286.841394758125;5296.682199068068;5310.20346947957;5335.839924802262;5766.423357664284;5771.192033115367;5773.16289138081;5773.942260577424;5774.105013722879;5478.753456094485;5527.281453411031;5547.44525547442;5566.137248726453;5604.607677462538;5661.433856614306;5666.97166514173;5673.971630141823;5677.09166533361;5680.261565996394;5633.57748168889;5641.351244606923;5642.520385767256;5650.74571644277;5669.348024977098;5558.916616250759;5598.804041858515;5670.858228544319;5696.401877802771;5711.228984087178;4286.335617979156;4287.013986782995;4288.120935208275;4299.570042995738;4329.675274354436;3840.0591854995705;3867.5165604299464;3875.5930627284292;3888.2417928504237;3906.374980003186;5347.705876176769;5372.7313634318125;5387.326584176978;5434;5435.782568697208;5649.435056494318;5653.660780353192;5659.292588426447;5662.660240385508;5668.716564171775;5220.556252718561;5342.031910323359;5363.329583802025;5370.140777475585;5385.892282154335;4912.1158191525865;4928.975355123202;4932.90134197314;4937.333459982929;4972.378452693413;5829.533637309005;5843.444872737168;5868.679547101868;5870.119482077637;5871.412858714094;5583.860403489945;5669.092945128759;5712.114622233477;5714.514266287412;5745.2818397700285;5783.566232532493;5824.5631577631;5837.883242335045;5841.1238314253205;5847.5906686533235;5581.804636837691;5584.944150558605;5587.664740115606;5597.384287728428;5602.383737788921;5585.050541408052;5666.490015898589;5667.121596152603;5723.112917497794;5745.971270143623;5534.059209934401;5537.390887002346;5540.833774986596;5542.919130769461;5548.805791797429;5459.454054594509;5461.098918678374;5472.124460086367;5491.478309560585;5524.861878453071;5274.947250527599;5381.004514164735;5404.2163886235485;5433.375161856279;5467.425920278313;5443.673379597237;5444.455554444524;5470.288862448016;5512.614117011771;5517.613767036269;5382.650127741685;5397.67613943149;5401;5404.135338345845;5408.053590621704 19:36:57 INFO - PROCESS | 14108 | |1;ext.html;553.2079841885884;577.3216470646992;578.3118089473526;592.9377415371385;593.8248216776051;38302.425463618034;38433.84698459044;38461.42307865384;38517.229655406874;38544;40983.38524922128;41644;41661.375079373836;41664;41734.165316693645;8491.745247642566;8622.78443038926;8629.439086459392;8644.135586441336;8649.481031138152;8574.657013719443;8719.346049046315;8723.563821808884;8898.37711360205;8923.286137109015;8863.822723545558;8925.196732294093;8945.686900958468;8945.910540894605;8946.64213431462;8824.426412283214;8901.198892099743;8907.955460222722;8908.8663670045;8911.331650126267;8758.343124265706;8869.46783193004;8879.51162686052;8886.86669699955;8888.333374996837;42053.1589368214;42456.36315455271;42518.362224566656;42553.148937021084;42589.57410425918;3617.855285788565;3761.755485893408;3856.093817952807;3961.485006949078;4436.4676238851225;32162.839185804154;32335.51496727551;32610;32666;33522.832385838155;4185.874423767292;4272.1028583997395;4300.204462174476;4316.56834316569;4317.266064768997;321456;321906;322384;323534;324284;54895.45104548903;59153;60050.699746501865;60125.398746012856;60150.398496015354;50817.745911270205;51091.744541277796;51123.74438127786;63906;64492.355076449574;15724.528264152093;15873.444429445144;15877.920610396874;15878.841211587967;15899.761503577456;12479.126461147815;12551.623451296477;12561.560345387868;12563.434645440977;12587.433565489575;17908.731369029476;19411.764705882466;19730.506737331394;19855.702164467544;19940.50148746264;7437.330640242404;7550.207228241065;7678;7699.692012319557;7777.377809775205;1008.8486726990864;1100.3837850803575;1102.1953973599318;1142.1833389126648;1149.8390225368455;28662.426751464853;28713.84646151547;28753.424931501253;29076.418471630448;29230.26924326909;1081.1837063017372;1130.0789856267281;1166.562539047857;1167.177140116233;1240.7580521798163;15720.449784257726;15772.92113539425;15808.36766529349;15823.841761582236;15840.60398490047;414166;415344;416166;416623;417182;56382.718086410125;57188.42811571914;57272.42727572671;57381;57468.71265643645;1320.518010926005;1419.6096073579847;1431.7065001674632;1437.173625165534;1437.2741765408402;28917.132486025454;29940.4011919756;30063.549046763877;30572.84713576418;30619.54070688897;42381.57618423776;42647.786761065996;42750.35874461948;42826.78586607047;42830.571694283906;269226;271246;271692;271711;272617;30875;35848.4622730654;36226.63773362338;36651.633483664824;36656.26687466182;41756.58243417648;41785;42168.68072256055;42343.5765642352;42448.57551424446;35386.46920296146;35954;36002.27995440129;36125;36160.27679446449;35330;36372.27255454929;37604.24791504209;38328.42507362336;38894.61105389023;39395.80302098471;39918.2016359677;40088.39867401933;40459.79770101131;40467.190656186125;32612.83693581517;33021;34555.30889382248;34895;35063;27417;27707.307317317227;27746.861265693544;27756.306092347044;27877.329766100196 19:36:57 INFO - PROCESS | 14108 | |2;jquery.html;355.71720482216637;361.2576155999421;362.52690239237785;371.55042398697566;378.65353201820335;17384.304627814887;17813.82186178138;18823.341183058597;18879.05604719762;18900.810991890077;18283.817161828378;18666;19300.227990880383;19319.61360772787;19341.419757407264;5460.208269800876;5619.606627536054;5630.521405680522;5645.604807663465;5688.886222275552;3343.7993720376853;4168.333066709327;6015.608985415955;6279.968600156993;6295.181626388563;6226.657533835637;6232.06519022148;6240.875182496347;6249.468795152417;6253.593516421441;5957.165996760457;6206.968965155145;6217.409346112112;6217.813465596039;6222.191115155024;3760.7555508891833;5144.717040562768;5408.215808707715;5412.2152287918425;5486.61593688442;20787.79212207889;21319;21463.67804482934;21605;21605.1357945682;2458.913938012161;2529.7849682776987;2712.823666461674;2841.829490230593;3079.5534647475993;13277.46890124394;13529;13556.525521606696;13903;14169.29153542329;1978.2878163861142;2025.6860186670942;2046.9181232750673;2065.4216819290623;2072;69292.64218216302;70594.64702676504;70698;71283.2871671287;72838;10653.414062226497;10787.568497260021;11013.614523491638;11103;11194.496247668874;14215.431382744575;14376.496822611158;14383;14394.928025360015;14406.351714172888;7932.643031063616;8049.235322644339;8086.797830054295;8158.347332213409;8242.258196762321;7752.26353496417;7762.573058481725;7776.7278145264645;7891.921080789233;7917.683292668229;6651.567648102858;6703.497237707192;6728.798136055926;6766.086578311865;6848.520603557803;1777.5022993561824;1834.7798264208113;1838.273881816675;1839.843613292885;1870.4741562155164;959.2565761534727;1065.8401239813934;1071.694567048403;1077.7521170130915;1157.5022740221787;18278.63442731138;18787.624247514974;18846.246150153842;19562.90218548898;20283.391498255078;1008.9192864570964;1078.8597482327248;1081.043276700126;1088.9128869690405;1117.0784103114963;11269.492872820743;11558.248713833742;11569.19015668895;11578.305301681927;11583.420828958519;474249;485429;488796;490139;552185;56206.71896640491;80491;82221;82947.17052829395;82983;1014.3812274512394;1087.722630729159;1156.525824411987;1171.7363593191465;1175.1010476985114;16904.40834570784;17091.829081709024;17384.913075435048;17568.38510652121;18613.06934653289;36491.63508364883;37727.434088489244;38121;38139;39113;47477.28784068311;47572;47660.04679906313;47723;48378.758106210655;8285.95857020711;8352.916470835215;8517.44636598619;8524;8616.698415555426;13447.529336473177;13578.728425431633;13653.317334133055;13783.104098233583;13800.930995345361;8013.439059265796;8450;9023.062790018092;10813.269876819671;11010.39442830652;11682.76634467323;11816.82274765862;11961.401929903295;12218.20581662189;12306.323152226356;11841.644750657493;12035.45840437165;12114.818277726017;12197.390130493262;12307.938460307641;7747.651355688895;7782.455228133977;8102.270795628422;8443.704470343508;8502.659893604186;8355.373346998878;10919.39943303126;11089.33463992163;11102.167337449562;11126.61056863006 19:36:57 INFO - PROCESS | 14108 | |3;mootools.html;1383.4327925550526;1541.337224993253;1553.8989965652231;1774.2814160265098;1902.6099649571847;8022.67909283628;8219.178082191786;8235.91764082359;8239.299659528948;8240.752777416672;8093.67625294989;8223.54770487623;8246.67013319468;8266.132056134109;8270.255676989069;2039.0314600564761;2078.064870808135;2276.1009401286483;2326.2090889097703;2356.69362982812;2325.2559181062065;2330.8718020508863;2331.0326214620914;2334.3580515358244;2334.5681049005902;2287.588234117858;2319.7332306784683;2348.3542025942834;2351.8000969917575;2357.4695693469002;2284.9200277990276;2343.039353864916;2345.097137602027;2369.158948573249;2370.0638247892157;2348.8120950323932;2361.480474295652;2380.214529205358;2385.367877512443;2389.8566086034893;8337.458065225741;8381.832363352698;8383.16168383163;8389.035260944947;8400.579971001425;5047.697138171721;5156.845294641167;5171.198464238049;5176.042432150064;5192.584593232532;3303.289792694582;3309.1230823831465;3368.8989330319882;3429.879954201616;3474.062003259106;1094.0973696700255;1102.9669109926715;1103.7626910214262;1117.7987962166808;1134.6028889888555;11229.55081796727;11232.943835280772;11249.493772780244;11262.718432039183;11275;4540.069285796404;4576.199165146086;4647.117047760915;4668.3697700810635;4672.906541869143;9716.562754676057;9753.902460975441;9776.266779991529;9781.141583099188;9790.265730070274;5087.669301495391;5105.974470127626;5115.5396014358885;5120.078385890575;5122.359705036871;4180.456540649696;4458.264386376277;4552.408186935677;4558.908821823611;4560.224761790503;4046.912114014275;4066.6340029397497;4101.5488296287385;4134.772587507716;4151.896202594899;1220.2190598017098;1225.2587184753274;1229.434460148324;1231.6243545718462;1236.6846454154313;1453.4840131753076;1472.124086168728;1479.1716638682371;1489.5531340597777;1505.3903169216485;7829.804254893559;7843.450958432855;7886.09309929354;7890.684372625145;7895.565743884026;506.6656007035339;515.7163560041962;516.042740715974;518.1450606499232;527.7677821758414;5988.04191329394;5992.550558708114;5992.730327135289;6049.606775559662;6061.393860613904;9791.216702663769;9940.204783617293;10105;10131.7467063324;10143.23925705575;9774.12032917041;9865.161461275871;9868.210543156674;9950.601975921027;10047.397156170653;7957.880631790527;7971.60141992898;8011.439199256112;8068.556229407439;8068.9596552016865;8027.518348899085;8063.83872322562;8126.75619731409;8131.105578386491;8209.83580328402;8791.428557143765;8986.505742184243;9310.48792316402;9421.62313507452;9507.762305942406;9169.35814492979;9169.77075573116;9340.206082483064;9555;9767.853482197916;6713.6307503085845;7276.563406195645;7402.1117465904435;7613.6573854175585;7757.26306000929;8035.67857285702;8044.195580442143;8072.273495385443;8090.919090809017;8092.271695547429;7141.464390170862;7273.3453989141235;7305.926940730525;7357.0803649543805;7407.444441667004;7111.7866464006165;7133.857322853618;7208.35124838767;7231.63841807918;7249.347558719741;7695.2304769524835;7732.574708390867;7733;7735.497192682457;7736.535807851547;6955.095837541289;6994.090768200102;7006.9649651751415;7007.859842803217;7010.298970102949;6725.663716814041;6819.181698196248;6823.727050917908;6825.795226143224;6826.658667066726 19:36:57 INFO - PROCESS | 14108 | |4;prototype.html;335.18717111005805;336.2853935387302;337.5426297367068;340.79381973905777;342.2094960640918;5919.911201331973;5980.312264089631;6009.87980240395;6015.398460153988;6030.216071910651;5821.3305469870975;5828.2423284973;5851.502622277111;5890.175375447441;5937.940620593804;4418.2268103082;4526.524714904937;4628.444586649607;4661.976690116545;4686.835960741375;4676.929846052312;4676.953230467686;4688.367070445497;4690.882727931795;4705.717656940595;4626.144163329778;4628.514006029369;4631.096936097462;4644.117617652652;4649.814007439699;4415.8233670653135;4512.16524942885;4613.538646135393;4631.235846085392;4632.8146874125;4068.3897415387632;4072.816723247461;4077.6330130288416;4082.2447847148374;4087.3255912774653;5709.685967271798;5761.395053519362;5767.971160144214;5772.451617096369;5774.364819869811;5317.760700768475;5318.601104917108;5322.0952438085615;5329.866753331159;5332.306800115999;6258.280297765769;6260.373962603749;6263.749450021994;6270.529710271702;6273.341299163568;4218.894527636803;4335.1979883721615;4343.348497725335;4350.869473915787;4480.977595112036;6452.580582262138;6461.19235095613;6480.805575832733;6517.348265173492;6518.641474718841;4366.886443956834;4388.824447022083;4390.692651514427;4393.033532622818;4395.1429471252795;4392.5607439256455;4407.294832826732;4432.977835110803;4434.889127771767;4435.379046933432;5161.148410512298;5169.4830516948;5173.275741396207;5175.171972484384;5181.481851814864;6149.200603921551;6319.526035547352;6323.30443651198;6329.68351582419;6344.143540622049;1566.945156919525;1574.4646820081227;1586.024594874144;1586.5954181683828;1592.410808001047;1000.2248257600272;1033.617561502249;1039.4854546999284;1063.2929102146986;1079.7732476179933;6003.7898673546215;6009.128676341906;6072.666003369857;6080.969595152084;6087;6459.870802584016;6465.094886715863;6469.094326794253;6469.417752402306;6470.870582588322;6016.909746353808;6050.152978583002;6077.1491991121275;6080;6082.118092876508;3458.3774920514047;3481.8607255709994;3492.5808902931813;3496.1609213789015;3497.4753786932165;6589.83525411859;6623.271440141581;6775.864482710417;6781.25406205317;6781.355771201728;6612.471002319803;6701.899471507932;6706.899396509057;6709.758694641507;6713.194416669933;6695.631740254333;6732.663366831639;6746.561473504108;6765.763198288037;6766.15423072116;6518.185226846645;6519.674016299261;6525.543211975116;6539.738410463528;6544;6295.842603934938;6482.286948435574;6513.609183449008;6520.315366886598;6534.379233972765;6675.23234828001;6692.196936367667;6713.966430168013;6732.528722989344;6755.256921738703;4453.4433195850515;4509.3686883836945;4510.50384457716;4513.796879140381;4515.006698526319;6486.0919471275;6535.052417399545;6539.182602174728;6540.117084193573;6540.149780528501;6170.136180934583;6306.936930630818;6356.809295721136;6357.396047375492;6366.267879193952;6259.311475737574;6334.429901308904;6344.555881088279;6346.079818426395;6350.1744773181035;6220.720067596879;6226.066090086523;6238.719257633508;6243.37566243372;6246.437820596168;6337.651429171256;6389.584676995981;6390.744370225325;6394.072859435449;6398.616083035033;5958.6424814511265;6078.513718902565;6080.604760690541;6241.625502469867;6249.843753906189 19:36:57 INFO - PROCESS | 14108 | |5;yui.html;753.58929383486;763.2482005224849;810.4245985350401;888.6894075403951;904.7240591619556;13541.390637421315;13547.051706380546;13609.591712248624;13683.726325473484;13982.230977296258;13084.280364579945;14206.928965355159;14217;14240;14276.714465710706;832.2343444031491;846.5640195299426;847.6100993542977;848.1010129263001;848.3594885861166;820.7414664380731;832.6544484039147;833.5790425834975;833.6915341323719;834.0116961400729;866.5927014303268;872.5549969515561;872.7512658892217;875.1860769484377;875.8423483772918;870.1255238485345;870.6865528409799;870.7561882672799;870.7561882672893;870.7823044238941;643.6492111799081;647.970841312142;648.870225954811;649.4933951517824;649.5712829532486;13326.533571325053;13369.264690442022;13379.397927093207;13393.388289283594;13413.195208287436;12250;12267.69330766729;12347.19743216688;12403.441845116991;12564.05769567277;10694.625688100958;10829;10870.61952831655;10987.835182472269;11318.434078296135;3783.6000679748668;3786.337390956599;3801.448789925473;3877.7479463835043;3933.370660694275;44084.338734919;47894;51341.22988155181;54141.45858541404;54416.455835441535;11256;11352.375619341015;11448.713782155513;11482.770344593062;11568.190226684052;19062.428127156207;19300.613987720168;19313.90343048276;19322.516937076685;19328.903355483133;8337;8454;8532.189442003;8558.572071396406;8687.305015598737;4642.442906851199;4764.928526072112;4782.808687652525;4838.371011768518;4952.603791696655;3358;3376.240345922197;3380.3408335374857;3384.0693809202667;3385.6952874241438;599.5743022454019;610.2585358789092;613.1814028272217;619.3125630550086;621.6363427394934;690.9930900691029;696.7944456385378;785.1206648553657;791.4538968111984;799.4363973398856;9683.370580912218;9783.755406114904;9793.853092203623;9805.705828825146;9918.900810991941;627.2504357293083;732.9230430804795;741.355021131619;784.3568274015253;804.9315808156255;4415.558444155623;4434.290513517822;4438.152962756221;4520.660950428731;4626.190416677068;61105.69447152736;61960;62483.687581561804;62714.686426567576;62768.686156568925;45849.54150458453;56024.71987640117;57907.42092579105;60531;61246.38753612407;50455;50905.23642145371;50955.23567146496;51248;51776.74111629418;9765.462899540309;9944.403335799876;10059.446730429603;10059.647912323033;10146.985301469795;36609.267814643026;38982;39464.80267598644;40405.595944040186;40693.79653101834;48703.5129648699;50576.49423505865;50604.74697626488;51519.74240128775;51624;12902.741945161231;13114.540991065267;13154.736905262032;13403.597892063253;13676.726465470834;12879.162854414433;12983.870161298266;13366;13570.525031623845;13691.178529288274;13005.284709340698;13494.12288201303;13868.86131138716;13977.091489053179;14008.789868151782;13183.14309569875;13493.730125397633;13935.233562153773;14082.577522674335;14174.716505670036;12721.872781272068;13080.149790263602;13274.668133296746;13300.135491193041;13515.189088654712;10475.52860121281;10649;10896.128309735044;10941;11062;11184.601330810608;11256.83114753263;11356.148288878532;11388.373639449579;11465.369404682822 19:36:57 INFO - PROCESS | 14108 | __end_tp_report 19:36:57 INFO - PROCESS | 14108 | __start_cc_report 19:36:57 INFO - PROCESS | 14108 | _x_x_mozilla_cycle_collect,788 19:36:57 INFO - PROCESS | 14108 | __end_cc_report 19:36:57 INFO - PROCESS | 14108 | __startTimestamp1457923017541__endTimestamp 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | ------- Summary: start ------- 19:36:57 INFO - PROCESS | 14108 | Number of tests: 6 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | [#0] dojo.html Cycles:165 Average:5269.27 Median:5434.00 stddev:577.72 (10.6%) stddev-sans-first:552.90 19:36:57 INFO - PROCESS | 14108 | Values: 3060.5 3091.5 3140.5 3148.3 3171.1 5268.3 5292.3 5323.2 5353.8 5381.9 5282.8 5307.2 5309.5 5327.2 5368.5 4796.8 4858.9 4868.0 5001.4 5006.5 4852.6 4915.8 4949.0 4949.5 5058.5 4878.5 4894.9 4916.0 4946.5 4970.6 4798.1 4841.0 4858.6 4860.1 4885.6 4793.9 4828.8 4856.5 4860.3 4873.0 5280.8 5287.0 5291.8 5293.8 5303.8 5654.5 5659.9 5674.7 5679.9 5704.3 5583.7 5673.3 5703.2 5706.7 5718.5 5275.6 5286.8 5296.7 5310.2 5335.8 5766.4 5771.2 5773.2 5773.9 5774.1 5478.8 5527.3 5547.4 5566.1 5604.6 5661.4 5667.0 5674.0 5677.1 5680.3 5633.6 5641.4 5642.5 5650.7 5669.3 5558.9 5598.8 5670.9 5696.4 5711.2 4286.3 4287.0 4288.1 4299.6 4329.7 3840.1 3867.5 3875.6 3888.2 3906.4 5347.7 5372.7 5387.3 5434.0 5435.8 5649.4 5653.7 5659.3 5662.7 5668.7 5220.6 5342.0 5363.3 5370.1 5385.9 4912.1 4929.0 4932.9 4937.3 4972.4 5829.5 5843.4 5868.7 5870.1 5871.4 5583.9 5669.1 5712.1 5714.5 5745.3 5783.6 5824.6 5837.9 5841.1 5847.6 5581.8 5584.9 5587.7 5597.4 5602.4 5585.1 5666.5 5667.1 5723.1 5746.0 5534.1 5537.4 5540.8 5542.9 5548.8 5459.5 5461.1 5472.1 5491.5 5524.9 5274.9 5381.0 5404.2 5433.4 5467.4 5443.7 5444.5 5470.3 5512.6 5517.6 5382.7 5397.7 5401.0 5404.1 5408.1 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | [#1] ext.html Cycles:180 Average:50526.60 Median:21200.05 stddev:89870.18 (423.9%) stddev-sans-first:90043.97 19:36:57 INFO - PROCESS | 14108 | Values: 553.2 577.3 578.3 592.9 593.8 38302.4 38433.8 38461.4 38517.2 38544.0 40983.4 41644.0 41661.4 41664.0 41734.2 8491.7 8622.8 8629.4 8644.1 8649.5 8574.7 8719.3 8723.6 8898.4 8923.3 8863.8 8925.2 8945.7 8945.9 8946.6 8824.4 8901.2 8908.0 8908.9 8911.3 8758.3 8869.5 8879.5 8886.9 8888.3 42053.2 42456.4 42518.4 42553.1 42589.6 3617.9 3761.8 3856.1 3961.5 4436.5 32162.8 32335.5 32610.0 32666.0 33522.8 4185.9 4272.1 4300.2 4316.6 4317.3 321456.0 321906.0 322384.0 323534.0 324284.0 54895.5 59153.0 60050.7 60125.4 60150.4 50817.7 51091.7 51123.7 63906.0 64492.4 15724.5 15873.4 15877.9 15878.8 15899.8 12479.1 12551.6 12561.6 12563.4 12587.4 17908.7 19411.8 19730.5 19855.7 19940.5 7437.3 7550.2 7678.0 7699.7 7777.4 1008.8 1100.4 1102.2 1142.2 1149.8 28662.4 28713.8 28753.4 29076.4 29230.3 1081.2 1130.1 1166.6 1167.2 1240.8 15720.4 15772.9 15808.4 15823.8 15840.6 414166.0 415344.0 416166.0 416623.0 417182.0 56382.7 57188.4 57272.4 57381.0 57468.7 1320.5 1419.6 1431.7 1437.2 1437.3 28917.1 29940.4 30063.5 30572.8 30619.5 42381.6 42647.8 42750.4 42826.8 42830.6 269226.0 271246.0 271692.0 271711.0 272617.0 30875.0 35848.5 36226.6 36651.6 36656.3 41756.6 41785.0 42168.7 42343.6 42448.6 35386.5 35954.0 36002.3 36125.0 36160.3 35330.0 36372.3 37604.2 38328.4 38894.6 39395.8 39918.2 40088.4 40459.8 40467.2 32612.8 33021.0 34555.3 34895.0 35063.0 27417.0 27707.3 27746.9 27756.3 27877.3 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | [#2] jquery.html Cycles:180 Average:28141.03 Median:2494.35 stddev:81680.53 (3274.6%) stddev-sans-first:81883.02 19:36:57 INFO - PROCESS | 14108 | Values: 355.7 361.3 362.5 371.6 378.7 17384.3 17813.8 18823.3 18879.1 18900.8 18283.8 18666.0 19300.2 19319.6 19341.4 5460.2 5619.6 5630.5 5645.6 5688.9 3343.8 4168.3 6015.6 6280.0 6295.2 6226.7 6232.1 6240.9 6249.5 6253.6 5957.2 6207.0 6217.4 6217.8 6222.2 3760.8 5144.7 5408.2 5412.2 5486.6 20787.8 21319.0 21463.7 21605.0 21605.1 2458.9 2529.8 2712.8 2841.8 3079.6 13277.5 13529.0 13556.5 13903.0 14169.3 1978.3 2025.7 2046.9 2065.4 2072.0 69292.6 70594.6 70698.0 71283.3 72838.0 10653.4 10787.6 11013.6 11103.0 11194.5 14215.4 14376.5 14383.0 14394.9 14406.4 7932.6 8049.2 8086.8 8158.3 8242.3 7752.3 7762.6 7776.7 7891.9 7917.7 6651.6 6703.5 6728.8 6766.1 6848.5 1777.5 1834.8 1838.3 1839.8 1870.5 959.3 1065.8 1071.7 1077.8 1157.5 18278.6 18787.6 18846.2 19562.9 20283.4 1008.9 1078.9 1081.0 1088.9 1117.1 11269.5 11558.2 11569.2 11578.3 11583.4 474249.0 485429.0 488796.0 490139.0 552185.0 56206.7 80491.0 82221.0 82947.2 82983.0 1014.4 1087.7 1156.5 1171.7 1175.1 16904.4 17091.8 17384.9 17568.4 18613.1 36491.6 37727.4 38121.0 38139.0 39113.0 47477.3 47572.0 47660.0 47723.0 48378.8 8286.0 8352.9 8517.4 8524.0 8616.7 13447.5 13578.7 13653.3 13783.1 13800.9 8013.4 8450.0 9023.1 10813.3 11010.4 11682.8 11816.8 11961.4 12218.2 12306.3 11841.6 12035.5 12114.8 12197.4 12307.9 7747.7 7782.5 8102.3 8443.7 8502.7 8355.4 10919.4 11089.3 11102.2 11126.6 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | [#3] mootools.html Cycles:180 Average:5837.66 Median:5992.64 stddev:3063.17 (51.1%) stddev-sans-first:3053.47 19:36:57 INFO - PROCESS | 14108 | Values: 1383.4 1541.3 1553.9 1774.3 1902.6 8022.7 8219.2 8235.9 8239.3 8240.8 8093.7 8223.5 8246.7 8266.1 8270.3 2039.0 2078.1 2276.1 2326.2 2356.7 2325.3 2330.9 2331.0 2334.4 2334.6 2287.6 2319.7 2348.4 2351.8 2357.5 2284.9 2343.0 2345.1 2369.2 2370.1 2348.8 2361.5 2380.2 2385.4 2389.9 8337.5 8381.8 8383.2 8389.0 8400.6 5047.7 5156.8 5171.2 5176.0 5192.6 3303.3 3309.1 3368.9 3429.9 3474.1 1094.1 1103.0 1103.8 1117.8 1134.6 11229.6 11232.9 11249.5 11262.7 11275.0 4540.1 4576.2 4647.1 4668.4 4672.9 9716.6 9753.9 9776.3 9781.1 9790.3 5087.7 5106.0 5115.5 5120.1 5122.4 4180.5 4458.3 4552.4 4558.9 4560.2 4046.9 4066.6 4101.5 4134.8 4151.9 1220.2 1225.3 1229.4 1231.6 1236.7 1453.5 1472.1 1479.2 1489.6 1505.4 7829.8 7843.5 7886.1 7890.7 7895.6 506.7 515.7 516.0 518.1 527.8 5988.0 5992.6 5992.7 6049.6 6061.4 9791.2 9940.2 10105.0 10131.7 10143.2 9774.1 9865.2 9868.2 9950.6 10047.4 7957.9 7971.6 8011.4 8068.6 8069.0 8027.5 8063.8 8126.8 8131.1 8209.8 8791.4 8986.5 9310.5 9421.6 9507.8 9169.4 9169.8 9340.2 9555.0 9767.9 6713.6 7276.6 7402.1 7613.7 7757.3 8035.7 8044.2 8072.3 8090.9 8092.3 7141.5 7273.3 7305.9 7357.1 7407.4 7111.8 7133.9 7208.4 7231.6 7249.3 7695.2 7732.6 7733.0 7735.5 7736.5 6955.1 6994.1 7007.0 7007.9 7010.3 6725.7 6819.2 6823.7 6825.8 6826.7 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | [#4] prototype.html Cycles:180 Average:5281.71 Median:6012.64 stddev:1589.78 (26.4%) stddev-sans-first:1550.28 19:36:57 INFO - PROCESS | 14108 | Values: 335.2 336.3 337.5 340.8 342.2 5919.9 5980.3 6009.9 6015.4 6030.2 5821.3 5828.2 5851.5 5890.2 5937.9 4418.2 4526.5 4628.4 4662.0 4686.8 4676.9 4677.0 4688.4 4690.9 4705.7 4626.1 4628.5 4631.1 4644.1 4649.8 4415.8 4512.2 4613.5 4631.2 4632.8 4068.4 4072.8 4077.6 4082.2 4087.3 5709.7 5761.4 5768.0 5772.5 5774.4 5317.8 5318.6 5322.1 5329.9 5332.3 6258.3 6260.4 6263.7 6270.5 6273.3 4218.9 4335.2 4343.3 4350.9 4481.0 6452.6 6461.2 6480.8 6517.3 6518.6 4366.9 4388.8 4390.7 4393.0 4395.1 4392.6 4407.3 4433.0 4434.9 4435.4 5161.1 5169.5 5173.3 5175.2 5181.5 6149.2 6319.5 6323.3 6329.7 6344.1 1566.9 1574.5 1586.0 1586.6 1592.4 1000.2 1033.6 1039.5 1063.3 1079.8 6003.8 6009.1 6072.7 6081.0 6087.0 6459.9 6465.1 6469.1 6469.4 6470.9 6016.9 6050.2 6077.1 6080.0 6082.1 3458.4 3481.9 3492.6 3496.2 3497.5 6589.8 6623.3 6775.9 6781.3 6781.4 6612.5 6701.9 6706.9 6709.8 6713.2 6695.6 6732.7 6746.6 6765.8 6766.2 6518.2 6519.7 6525.5 6539.7 6544.0 6295.8 6482.3 6513.6 6520.3 6534.4 6675.2 6692.2 6714.0 6732.5 6755.3 4453.4 4509.4 4510.5 4513.8 4515.0 6486.1 6535.1 6539.2 6540.1 6540.1 6170.1 6306.9 6356.8 6357.4 6366.3 6259.3 6334.4 6344.6 6346.1 6350.2 6220.7 6226.1 6238.7 6243.4 6246.4 6337.7 6389.6 6390.7 6394.1 6398.6 5958.6 6078.5 6080.6 6241.6 6249.8 19:36:57 INFO - PROCESS | 14108 | 19:36:57 INFO - PROCESS | 14108 | [#5] yui.html Cycles:180 Average:15165.29 Median:4436.22 stddev:17437.08 (393.1%) stddev-sans-first:17452.41 19:36:57 INFO - PROCESS | 14108 | Values: 753.6 763.2 810.4 888.7 904.7 13541.4 13547.1 13609.6 13683.7 13982.2 13084.3 14206.9 14217.0 14240.0 14276.7 832.2 846.6 847.6 848.1 848.4 820.7 832.7 833.6 833.7 834.0 866.6 872.6 872.8 875.2 875.8 870.1 870.7 870.8 870.8 870.8 643.6 648.0 648.9 649.5 649.6 13326.5 13369.3 13379.4 13393.4 13413.2 12250.0 12267.7 12347.2 12403.4 12564.1 10694.6 10829.0 10870.6 10987.8 11318.4 3783.6 3786.3 3801.4 3877.7 3933.4 44084.3 47894.0 51341.2 54141.5 54416.5 11256.0 11352.4 11448.7 11482.8 11568.2 19062.4 19300.6 19313.9 19322.5 19328.9 8337.0 8454.0 8532.2 8558.6 8687.3 4642.4 4764.9 4782.8 4838.4 4952.6 3358.0 3376.2 3380.3 3384.1 3385.7 599.6 610.3 613.2 619.3 621.6 691.0 696.8 785.1 791.5 799.4 9683.4 9783.8 9793.9 9805.7 9918.9 627.3 732.9 741.4 784.4 804.9 4415.6 4434.3 4438.2 4520.7 4626.2 61105.7 61960.0 62483.7 62714.7 62768.7 45849.5 56024.7 57907.4 60531.0 61246.4 50455.0 50905.2 50955.2 51248.0 51776.7 9765.5 9944.4 10059.4 10059.6 10147.0 36609.3 38982.0 39464.8 40405.6 40693.8 48703.5 50576.5 50604.7 51519.7 51624.0 12902.7 13114.5 13154.7 13403.6 13676.7 12879.2 12983.9 13366.0 13570.5 13691.2 13005.3 13494.1 13868.9 13977.1 14008.8 13183.1 13493.7 13935.2 14082.6 14174.7 12721.9 13080.1 13274.7 13300.1 13515.2 10475.5 10649.0 10896.1 10941.0 11062.0 11184.6 11256.8 11356.1 11388.4 11465.4 19:36:57 INFO - PROCESS | 14108 | -------- Summary: end -------- 19:36:57 INFO - PROCESS | 14108 | 19:36:58 INFO - TEST-INFO | 14108: exit 0 19:36:58 INFO - TEST-OK | dromaeo_css | took 1112526ms 19:36:58 INFO - TEST-START | kraken 19:36:58 INFO - operating with platform_type : linux_ 19:36:58 INFO - Initialising browser for kraken test... 19:36:58 INFO - TEST-INFO | started process 14294 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQAcAm0/profile http://localhost:50369/getInfo.html) 19:37:02 INFO - PROCESS | 14294 | __metrics Screen width/height:1600/1200 19:37:02 INFO - PROCESS | 14294 | colorDepth:24 19:37:02 INFO - PROCESS | 14294 | Browser inner width/height: 1024/697 19:37:02 INFO - PROCESS | 14294 | __metrics 19:37:03 ERROR - PROCESS | 14294 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:37:04 INFO - TEST-INFO | 14294: exit 0 19:37:04 INFO - Browser initialized. 19:37:04 INFO - Running cycle 1/1 for kraken test... 19:37:04 INFO - TEST-INFO | started process 14375 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQAcAm0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:16 INFO - PROCESS | 14375 | RSS: Main: 152981504 19:37:16 INFO - PROCESS | 14375 | 19:37:18 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50369/tests/kraken/driver.html?testName=audio-beat-detection) 19:37:19 INFO - PROCESS | 14375 | RSS: Main: 193732608 19:37:19 INFO - PROCESS | 14375 | 19:37:22 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50369/tests/kraken/driver.html?testName=audio-dft) 19:37:22 INFO - PROCESS | 14375 | RSS: Main: 185069568 19:37:22 INFO - PROCESS | 14375 | 19:37:27 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50369/tests/kraken/driver.html?testName=audio-fft) 19:37:28 INFO - PROCESS | 14375 | RSS: Main: 173420544 19:37:28 INFO - PROCESS | 14375 | 19:37:30 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50369/tests/kraken/driver.html?testName=audio-oscillator) 19:37:31 INFO - PROCESS | 14375 | RSS: Main: 173965312 19:37:31 INFO - PROCESS | 14375 | 19:37:33 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:37:33 INFO - PROCESS | 14375 | RSS: Main: 173834240 19:37:33 INFO - PROCESS | 14375 | 19:37:36 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50369/tests/kraken/driver.html?testName=imaging-darkroom) 19:37:37 INFO - PROCESS | 14375 | RSS: Main: 174817280 19:37:37 INFO - PROCESS | 14375 | 19:37:41 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50369/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:41 INFO - PROCESS | 14375 | RSS: Main: 173379584 19:37:41 INFO - PROCESS | 14375 | 19:37:44 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50369/tests/kraken/driver.html?testName=json-parse-financial) 19:37:45 INFO - PROCESS | 14375 | RSS: Main: 173264896 19:37:45 INFO - PROCESS | 14375 | 19:37:46 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:47 INFO - PROCESS | 14375 | RSS: Main: 187904000 19:37:47 INFO - PROCESS | 14375 | 19:37:49 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:49 INFO - PROCESS | 14375 | RSS: Main: 184623104 19:37:49 INFO - PROCESS | 14375 | 19:37:51 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:52 INFO - PROCESS | 14375 | RSS: Main: 194547712 19:37:52 INFO - PROCESS | 14375 | 19:37:54 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:55 INFO - PROCESS | 14375 | RSS: Main: 201527296 19:37:55 INFO - PROCESS | 14375 | 19:37:57 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:58 INFO - PROCESS | 14375 | RSS: Main: 200880128 19:37:58 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | Cycle 1(1): loaded http://localhost:50369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50369/tests/kraken/driver.html?testName=ai-astar) 19:38:00 INFO - PROCESS | 14375 | RSS: Main: 259866624 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | __start_tp_report 19:38:00 INFO - PROCESS | 14375 | _x_x_mozilla_page_load 19:38:00 INFO - PROCESS | 14375 | _x_x_mozilla_page_load_details 19:38:00 INFO - PROCESS | 14375 | |i|pagename|runs| 19:38:00 INFO - PROCESS | 14375 | |0;ai-astar;109;109;104;109;110;110;100;110;111;109 19:38:00 INFO - PROCESS | 14375 | |1;audio-beat-detection;151;131;156;163;127;165;160;124;167;125 19:38:00 INFO - PROCESS | 14375 | |2;audio-dft;376;376;379;374;377;378;378;378;377;375 19:38:00 INFO - PROCESS | 14375 | |3;audio-fft;74;74;73;164;75;77;83;74;163;74 19:38:00 INFO - PROCESS | 14375 | |4;audio-oscillator;93;92;145;92;94;93;143;92;93;138 19:38:00 INFO - PROCESS | 14375 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;116;118 19:38:00 INFO - PROCESS | 14375 | |6;imaging-darkroom;192;193;192;192;192;192;192;192;192;192 19:38:00 INFO - PROCESS | 14375 | |7;imaging-desaturate;96;95;95;95;96;96;96;96;95;97 19:38:00 INFO - PROCESS | 14375 | |8;json-parse-financial;56;57;58;56;58;57;61;56;56;57 19:38:00 INFO - PROCESS | 14375 | |9;json-stringify-tinderbox;60;60;59;59;60;61;61;60;60;60 19:38:00 INFO - PROCESS | 14375 | |10;stanford-crypto-aes;76;76;78;85;77;78;77;77;88;80 19:38:00 INFO - PROCESS | 14375 | |11;stanford-crypto-ccm;112;111;109;109;116;119;108;119;109;121 19:38:00 INFO - PROCESS | 14375 | |12;stanford-crypto-pbkdf2;144;142;143;143;145;135;141;153;141;141 19:38:00 INFO - PROCESS | 14375 | |13;stanford-crypto-sha256-iterative;65;65;63;63;62;62;66;64;63;67 19:38:00 INFO - PROCESS | 14375 | __end_tp_report 19:38:00 INFO - PROCESS | 14375 | __start_cc_report 19:38:00 INFO - PROCESS | 14375 | _x_x_mozilla_cycle_collect,1007 19:38:00 INFO - PROCESS | 14375 | __end_cc_report 19:38:00 INFO - PROCESS | 14375 | __startTimestamp1457923080287__endTimestamp 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | ------- Summary: start ------- 19:38:00 INFO - PROCESS | 14375 | Number of tests: 14 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:3.41 (3.1%) stddev-sans-first:3.61 19:38:00 INFO - PROCESS | 14375 | Values: 109.0 109.0 104.0 109.0 110.0 110.0 100.0 110.0 111.0 109.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:158.00 stddev:18.00 (11.4%) stddev-sans-first:19.03 19:38:00 INFO - PROCESS | 14375 | Values: 151.0 131.0 156.0 163.0 127.0 165.0 160.0 124.0 167.0 125.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#2] audio-dft Cycles:10 Average:376.80 Median:377.50 stddev:1.55 (0.4%) stddev-sans-first:1.62 19:38:00 INFO - PROCESS | 14375 | Values: 376.0 376.0 379.0 374.0 377.0 378.0 378.0 378.0 377.0 375.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#3] audio-fft Cycles:10 Average:93.10 Median:74.00 stddev:37.22 (50.3%) stddev-sans-first:38.83 19:38:00 INFO - PROCESS | 14375 | Values: 74.0 74.0 73.0 164.0 75.0 77.0 83.0 74.0 163.0 74.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:92.50 stddev:23.88 (25.8%) stddev-sans-first:24.74 19:38:00 INFO - PROCESS | 14375 | Values: 93.0 92.0 145.0 92.0 94.0 93.0 143.0 92.0 93.0 138.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 19:38:00 INFO - PROCESS | 14375 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#6] imaging-darkroom Cycles:10 Average:192.10 Median:192.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 19:38:00 INFO - PROCESS | 14375 | Values: 192.0 193.0 192.0 192.0 192.0 192.0 192.0 192.0 192.0 192.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:38:00 INFO - PROCESS | 14375 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 97.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.55 (2.7%) stddev-sans-first:1.58 19:38:00 INFO - PROCESS | 14375 | Values: 56.0 57.0 58.0 56.0 58.0 57.0 61.0 56.0 56.0 57.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 19:38:00 INFO - PROCESS | 14375 | Values: 60.0 60.0 59.0 59.0 60.0 61.0 61.0 60.0 60.0 60.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.00 stddev:4.08 (5.2%) stddev-sans-first:4.16 19:38:00 INFO - PROCESS | 14375 | Values: 76.0 76.0 78.0 85.0 77.0 78.0 77.0 77.0 88.0 80.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#11] stanford-crypto-ccm Cycles:10 Average:113.30 Median:114.00 stddev:4.97 (4.4%) stddev-sans-first:5.25 19:38:00 INFO - PROCESS | 14375 | Values: 112.0 111.0 109.0 109.0 116.0 119.0 108.0 119.0 109.0 121.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:143.00 stddev:4.49 (3.1%) stddev-sans-first:4.74 19:38:00 INFO - PROCESS | 14375 | Values: 144.0 142.0 143.0 143.0 145.0 135.0 141.0 153.0 141.0 141.0 19:38:00 INFO - PROCESS | 14375 | 19:38:00 INFO - PROCESS | 14375 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.70 (2.6%) stddev-sans-first:1.76 19:38:00 INFO - PROCESS | 14375 | Values: 65.0 65.0 63.0 63.0 62.0 62.0 66.0 64.0 63.0 67.0 19:38:00 INFO - PROCESS | 14375 | -------- Summary: end -------- 19:38:00 INFO - PROCESS | 14375 | 19:38:01 INFO - TEST-INFO | 14375: exit 0 19:38:01 INFO - TEST-OK | kraken | took 62888ms 19:38:01 INFO - SUITE-END | took 1175s 19:38:01 INFO - Completed test suite (00:19:35) 19:38:01 INFO - javascript benchmark 19:38:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3060.464418726723, 3091.5208142737883, 3140.513220450831, 3148.307372378076, 3171.08038668786, 5268.262443257947, 5292.311999440072, 5323.201519772036, 5353.812616558416, 5381.865453363668, 5282.788688452457, 5307.20391941209, 5309.548688361494, 5327.174287985359, 5368.516833484995, 4796.808127674889, 4858.902821943559, 4867.977724677822, 5001.399832020163, 5006.499350065001, 4852.563269305761, 4915.82794602189, 4948.960718249172, 4949.455559888409, 5058.544730974211, 4878.512148785128, 4894.926576101361, 4916.0, 4946.530079642428, 4970.627202959774, 4798.112349215371, 4840.975795121037, 4858.611311095139, 4860.05228980349, 4885.6335774817035, 4793.9280910786365, 4828.830990915336, 4856.538628830255, 4860.343853579792, 4873.0, 5280.762365693553, 5287.0, 5291.814786482493, 5293.788248470057, 5303.761330740126, 5654.46282603152, 5659.943400565983, 5674.716264186774, 5679.886402271973, 5704.258446401983, 5583.664980101166, 5673.290838645169, 5703.201551782754, 5706.743196556124, 5718.485336319751, 5275.63070585063, 5286.841394758125, 5296.682199068068, 5310.20346947957, 5335.839924802262, 5766.423357664284, 5771.192033115367, 5773.16289138081, 5773.942260577424, 5774.105013722879, 5478.753456094485, 5527.281453411031, 5547.44525547442, 5566.137248726453, 5604.607677462538, 5661.433856614306, 5666.97166514173, 5673.971630141823, 5677.09166533361, 5680.261565996394, 5633.57748168889, 5641.351244606923, 5642.520385767256, 5650.74571644277, 5669.348024977098, 5558.916616250759, 5598.804041858515, 5670.858228544319, 5696.401877802771, 5711.228984087178, 4286.335617979156, 4287.013986782995, 4288.120935208275, 4299.570042995738, 4329.675274354436, 3840.0591854995705, 3867.5165604299464, 3875.5930627284292, 3888.2417928504237, 3906.374980003186, 5347.705876176769, 5372.7313634318125, 5387.326584176978, 5434.0, 5435.782568697208, 5649.435056494318, 5653.660780353192, 5659.292588426447, 5662.660240385508, 5668.716564171775, 5220.556252718561, 5342.031910323359, 5363.329583802025, 5370.140777475585, 5385.892282154335, 4912.1158191525865, 4928.975355123202, 4932.90134197314, 4937.333459982929, 4972.378452693413, 5829.533637309005, 5843.444872737168, 5868.679547101868, 5870.119482077637, 5871.412858714094, 5583.860403489945, 5669.092945128759, 5712.114622233477, 5714.514266287412, 5745.2818397700285, 5783.566232532493, 5824.5631577631, 5837.883242335045, 5841.1238314253205, 5847.5906686533235, 5581.804636837691, 5584.944150558605, 5587.664740115606, 5597.384287728428, 5602.383737788921, 5585.050541408052, 5666.490015898589, 5667.121596152603, 5723.112917497794, 5745.971270143623, 5534.059209934401, 5537.390887002346, 5540.833774986596, 5542.919130769461, 5548.805791797429, 5459.454054594509, 5461.098918678374, 5472.124460086367, 5491.478309560585, 5524.861878453071, 5274.947250527599, 5381.004514164735, 5404.2163886235485, 5433.375161856279, 5467.425920278313, 5443.673379597237, 5444.455554444524, 5470.288862448016, 5512.614117011771, 5517.613767036269, 5382.650127741685, 5397.67613943149, 5401.0, 5404.135338345845, 5408.053590621704], "unit": "score", "name": "dojo.html", "value": 5231.46227377712}, {"lowerIsBetter": false, "replicates": [553.2079841885884, 577.3216470646992, 578.3118089473526, 592.9377415371385, 593.8248216776051, 38302.425463618034, 38433.84698459044, 38461.42307865384, 38517.229655406874, 38544.0, 40983.38524922128, 41644.0, 41661.375079373836, 41664.0, 41734.165316693645, 8491.745247642566, 8622.78443038926, 8629.439086459392, 8644.135586441336, 8649.481031138152, 8574.657013719443, 8719.346049046315, 8723.563821808884, 8898.37711360205, 8923.286137109015, 8863.822723545558, 8925.196732294093, 8945.686900958468, 8945.910540894605, 8946.64213431462, 8824.426412283214, 8901.198892099743, 8907.955460222722, 8908.8663670045, 8911.331650126267, 8758.343124265706, 8869.46783193004, 8879.51162686052, 8886.86669699955, 8888.333374996837, 42053.1589368214, 42456.36315455271, 42518.362224566656, 42553.148937021084, 42589.57410425918, 3617.855285788565, 3761.755485893408, 3856.093817952807, 3961.485006949078, 4436.4676238851225, 32162.839185804154, 32335.51496727551, 32610.0, 32666.0, 33522.832385838155, 4185.874423767292, 4272.1028583997395, 4300.204462174476, 4316.56834316569, 4317.266064768997, 321456.0, 321906.0, 322384.0, 323534.0, 324284.0, 54895.45104548903, 59153.0, 60050.699746501865, 60125.398746012856, 60150.398496015354, 50817.745911270205, 51091.744541277796, 51123.74438127786, 63906.0, 64492.355076449574, 15724.528264152093, 15873.444429445144, 15877.920610396874, 15878.841211587967, 15899.761503577456, 12479.126461147815, 12551.623451296477, 12561.560345387868, 12563.434645440977, 12587.433565489575, 17908.731369029476, 19411.764705882466, 19730.506737331394, 19855.702164467544, 19940.50148746264, 7437.330640242404, 7550.207228241065, 7678.0, 7699.692012319557, 7777.377809775205, 1008.8486726990864, 1100.3837850803575, 1102.1953973599318, 1142.1833389126648, 1149.8390225368455, 28662.426751464853, 28713.84646151547, 28753.424931501253, 29076.418471630448, 29230.26924326909, 1081.1837063017372, 1130.0789856267281, 1166.562539047857, 1167.177140116233, 1240.7580521798163, 15720.449784257726, 15772.92113539425, 15808.36766529349, 15823.841761582236, 15840.60398490047, 414166.0, 415344.0, 416166.0, 416623.0, 417182.0, 56382.718086410125, 57188.42811571914, 57272.42727572671, 57381.0, 57468.71265643645, 1320.518010926005, 1419.6096073579847, 1431.7065001674632, 1437.173625165534, 1437.2741765408402, 28917.132486025454, 29940.4011919756, 30063.549046763877, 30572.84713576418, 30619.54070688897, 42381.57618423776, 42647.786761065996, 42750.35874461948, 42826.78586607047, 42830.571694283906, 269226.0, 271246.0, 271692.0, 271711.0, 272617.0, 30875.0, 35848.4622730654, 36226.63773362338, 36651.633483664824, 36656.26687466182, 41756.58243417648, 41785.0, 42168.68072256055, 42343.5765642352, 42448.57551424446, 35386.46920296146, 35954.0, 36002.27995440129, 36125.0, 36160.27679446449, 35330.0, 36372.27255454929, 37604.24791504209, 38328.42507362336, 38894.61105389023, 39395.80302098471, 39918.2016359677, 40088.39867401933, 40459.79770101131, 40467.190656186125, 32612.83693581517, 33021.0, 34555.30889382248, 34895.0, 35063.0, 27417.0, 27707.307317317227, 27746.861265693544, 27756.306092347044, 27877.329766100196], "unit": "score", "name": "ext.html", "value": 19279.03306607622}, {"lowerIsBetter": false, "replicates": [355.71720482216637, 361.2576155999421, 362.52690239237785, 371.55042398697566, 378.65353201820335, 17384.304627814887, 17813.82186178138, 18823.341183058597, 18879.05604719762, 18900.810991890077, 18283.817161828378, 18666.0, 19300.227990880383, 19319.61360772787, 19341.419757407264, 5460.208269800876, 5619.606627536054, 5630.521405680522, 5645.604807663465, 5688.886222275552, 3343.7993720376853, 4168.333066709327, 6015.608985415955, 6279.968600156993, 6295.181626388563, 6226.657533835637, 6232.06519022148, 6240.875182496347, 6249.468795152417, 6253.593516421441, 5957.165996760457, 6206.968965155145, 6217.409346112112, 6217.813465596039, 6222.191115155024, 3760.7555508891833, 5144.717040562768, 5408.215808707715, 5412.2152287918425, 5486.61593688442, 20787.79212207889, 21319.0, 21463.67804482934, 21605.0, 21605.1357945682, 2458.913938012161, 2529.7849682776987, 2712.823666461674, 2841.829490230593, 3079.5534647475993, 13277.46890124394, 13529.0, 13556.525521606696, 13903.0, 14169.29153542329, 1978.2878163861142, 2025.6860186670942, 2046.9181232750673, 2065.4216819290623, 2072.0, 69292.64218216302, 70594.64702676504, 70698.0, 71283.2871671287, 72838.0, 10653.414062226497, 10787.568497260021, 11013.614523491638, 11103.0, 11194.496247668874, 14215.431382744575, 14376.496822611158, 14383.0, 14394.928025360015, 14406.351714172888, 7932.643031063616, 8049.235322644339, 8086.797830054295, 8158.347332213409, 8242.258196762321, 7752.26353496417, 7762.573058481725, 7776.7278145264645, 7891.921080789233, 7917.683292668229, 6651.567648102858, 6703.497237707192, 6728.798136055926, 6766.086578311865, 6848.520603557803, 1777.5022993561824, 1834.7798264208113, 1838.273881816675, 1839.843613292885, 1870.4741562155164, 959.2565761534727, 1065.8401239813934, 1071.694567048403, 1077.7521170130915, 1157.5022740221787, 18278.63442731138, 18787.624247514974, 18846.246150153842, 19562.90218548898, 20283.391498255078, 1008.9192864570964, 1078.8597482327248, 1081.043276700126, 1088.9128869690405, 1117.0784103114963, 11269.492872820743, 11558.248713833742, 11569.19015668895, 11578.305301681927, 11583.420828958519, 474249.0, 485429.0, 488796.0, 490139.0, 552185.0, 56206.71896640491, 80491.0, 82221.0, 82947.17052829395, 82983.0, 1014.3812274512394, 1087.722630729159, 1156.525824411987, 1171.7363593191465, 1175.1010476985114, 16904.40834570784, 17091.829081709024, 17384.913075435048, 17568.38510652121, 18613.06934653289, 36491.63508364883, 37727.434088489244, 38121.0, 38139.0, 39113.0, 47477.28784068311, 47572.0, 47660.04679906313, 47723.0, 48378.758106210655, 8285.95857020711, 8352.916470835215, 8517.44636598619, 8524.0, 8616.698415555426, 13447.529336473177, 13578.728425431633, 13653.317334133055, 13783.104098233583, 13800.930995345361, 8013.439059265796, 8450.0, 9023.062790018092, 10813.269876819671, 11010.39442830652, 11682.76634467323, 11816.82274765862, 11961.401929903295, 12218.20581662189, 12306.323152226356, 11841.644750657493, 12035.45840437165, 12114.818277726017, 12197.390130493262, 12307.938460307641, 7747.651355688895, 7782.455228133977, 8102.270795628422, 8443.704470343508, 8502.659893604186, 8355.373346998878, 10919.39943303126, 11089.33463992163, 11102.167337449562, 11126.61056863006], "unit": "score", "name": "jquery.html", "value": 9191.532068539216}, {"lowerIsBetter": false, "replicates": [1383.4327925550526, 1541.337224993253, 1553.8989965652231, 1774.2814160265098, 1902.6099649571847, 8022.67909283628, 8219.178082191786, 8235.91764082359, 8239.299659528948, 8240.752777416672, 8093.67625294989, 8223.54770487623, 8246.67013319468, 8266.132056134109, 8270.255676989069, 2039.0314600564761, 2078.064870808135, 2276.1009401286483, 2326.2090889097703, 2356.69362982812, 2325.2559181062065, 2330.8718020508863, 2331.0326214620914, 2334.3580515358244, 2334.5681049005902, 2287.588234117858, 2319.7332306784683, 2348.3542025942834, 2351.8000969917575, 2357.4695693469002, 2284.9200277990276, 2343.039353864916, 2345.097137602027, 2369.158948573249, 2370.0638247892157, 2348.8120950323932, 2361.480474295652, 2380.214529205358, 2385.367877512443, 2389.8566086034893, 8337.458065225741, 8381.832363352698, 8383.16168383163, 8389.035260944947, 8400.579971001425, 5047.697138171721, 5156.845294641167, 5171.198464238049, 5176.042432150064, 5192.584593232532, 3303.289792694582, 3309.1230823831465, 3368.8989330319882, 3429.879954201616, 3474.062003259106, 1094.0973696700255, 1102.9669109926715, 1103.7626910214262, 1117.7987962166808, 1134.6028889888555, 11229.55081796727, 11232.943835280772, 11249.493772780244, 11262.718432039183, 11275.0, 4540.069285796404, 4576.199165146086, 4647.117047760915, 4668.3697700810635, 4672.906541869143, 9716.562754676057, 9753.902460975441, 9776.266779991529, 9781.141583099188, 9790.265730070274, 5087.669301495391, 5105.974470127626, 5115.5396014358885, 5120.078385890575, 5122.359705036871, 4180.456540649696, 4458.264386376277, 4552.408186935677, 4558.908821823611, 4560.224761790503, 4046.912114014275, 4066.6340029397497, 4101.5488296287385, 4134.772587507716, 4151.896202594899, 1220.2190598017098, 1225.2587184753274, 1229.434460148324, 1231.6243545718462, 1236.6846454154313, 1453.4840131753076, 1472.124086168728, 1479.1716638682371, 1489.5531340597777, 1505.3903169216485, 7829.804254893559, 7843.450958432855, 7886.09309929354, 7890.684372625145, 7895.565743884026, 506.6656007035339, 515.7163560041962, 516.042740715974, 518.1450606499232, 527.7677821758414, 5988.04191329394, 5992.550558708114, 5992.730327135289, 6049.606775559662, 6061.393860613904, 9791.216702663769, 9940.204783617293, 10105.0, 10131.7467063324, 10143.23925705575, 9774.12032917041, 9865.161461275871, 9868.210543156674, 9950.601975921027, 10047.397156170653, 7957.880631790527, 7971.60141992898, 8011.439199256112, 8068.556229407439, 8068.9596552016865, 8027.518348899085, 8063.83872322562, 8126.75619731409, 8131.105578386491, 8209.83580328402, 8791.428557143765, 8986.505742184243, 9310.48792316402, 9421.62313507452, 9507.762305942406, 9169.35814492979, 9169.77075573116, 9340.206082483064, 9555.0, 9767.853482197916, 6713.6307503085845, 7276.563406195645, 7402.1117465904435, 7613.6573854175585, 7757.26306000929, 8035.67857285702, 8044.195580442143, 8072.273495385443, 8090.919090809017, 8092.271695547429, 7141.464390170862, 7273.3453989141235, 7305.926940730525, 7357.0803649543805, 7407.444441667004, 7111.7866464006165, 7133.857322853618, 7208.35124838767, 7231.63841807918, 7249.347558719741, 7695.2304769524835, 7732.574708390867, 7733.0, 7735.497192682457, 7736.535807851547, 6955.095837541289, 6994.090768200102, 7006.9649651751415, 7007.859842803217, 7010.298970102949, 6725.663716814041, 6819.181698196248, 6823.727050917908, 6825.795226143224, 6826.658667066726], "unit": "score", "name": "mootools.html", "value": 4703.420201339658}, {"lowerIsBetter": false, "replicates": [335.18717111005805, 336.2853935387302, 337.5426297367068, 340.79381973905777, 342.2094960640918, 5919.911201331973, 5980.312264089631, 6009.87980240395, 6015.398460153988, 6030.216071910651, 5821.3305469870975, 5828.2423284973, 5851.502622277111, 5890.175375447441, 5937.940620593804, 4418.2268103082, 4526.524714904937, 4628.444586649607, 4661.976690116545, 4686.835960741375, 4676.929846052312, 4676.953230467686, 4688.367070445497, 4690.882727931795, 4705.717656940595, 4626.144163329778, 4628.514006029369, 4631.096936097462, 4644.117617652652, 4649.814007439699, 4415.8233670653135, 4512.16524942885, 4613.538646135393, 4631.235846085392, 4632.8146874125, 4068.3897415387632, 4072.816723247461, 4077.6330130288416, 4082.2447847148374, 4087.3255912774653, 5709.685967271798, 5761.395053519362, 5767.971160144214, 5772.451617096369, 5774.364819869811, 5317.760700768475, 5318.601104917108, 5322.0952438085615, 5329.866753331159, 5332.306800115999, 6258.280297765769, 6260.373962603749, 6263.749450021994, 6270.529710271702, 6273.341299163568, 4218.894527636803, 4335.1979883721615, 4343.348497725335, 4350.869473915787, 4480.977595112036, 6452.580582262138, 6461.19235095613, 6480.805575832733, 6517.348265173492, 6518.641474718841, 4366.886443956834, 4388.824447022083, 4390.692651514427, 4393.033532622818, 4395.1429471252795, 4392.5607439256455, 4407.294832826732, 4432.977835110803, 4434.889127771767, 4435.379046933432, 5161.148410512298, 5169.4830516948, 5173.275741396207, 5175.171972484384, 5181.481851814864, 6149.200603921551, 6319.526035547352, 6323.30443651198, 6329.68351582419, 6344.143540622049, 1566.945156919525, 1574.4646820081227, 1586.024594874144, 1586.5954181683828, 1592.410808001047, 1000.2248257600272, 1033.617561502249, 1039.4854546999284, 1063.2929102146986, 1079.7732476179933, 6003.7898673546215, 6009.128676341906, 6072.666003369857, 6080.969595152084, 6087.0, 6459.870802584016, 6465.094886715863, 6469.094326794253, 6469.417752402306, 6470.870582588322, 6016.909746353808, 6050.152978583002, 6077.1491991121275, 6080.0, 6082.118092876508, 3458.3774920514047, 3481.8607255709994, 3492.5808902931813, 3496.1609213789015, 3497.4753786932165, 6589.83525411859, 6623.271440141581, 6775.864482710417, 6781.25406205317, 6781.355771201728, 6612.471002319803, 6701.899471507932, 6706.899396509057, 6709.758694641507, 6713.194416669933, 6695.631740254333, 6732.663366831639, 6746.561473504108, 6765.763198288037, 6766.15423072116, 6518.185226846645, 6519.674016299261, 6525.543211975116, 6539.738410463528, 6544.0, 6295.842603934938, 6482.286948435574, 6513.609183449008, 6520.315366886598, 6534.379233972765, 6675.23234828001, 6692.196936367667, 6713.966430168013, 6732.528722989344, 6755.256921738703, 4453.4433195850515, 4509.3686883836945, 4510.50384457716, 4513.796879140381, 4515.006698526319, 6486.0919471275, 6535.052417399545, 6539.182602174728, 6540.117084193573, 6540.149780528501, 6170.136180934583, 6306.936930630818, 6356.809295721136, 6357.396047375492, 6366.267879193952, 6259.311475737574, 6334.429901308904, 6344.555881088279, 6346.079818426395, 6350.1744773181035, 6220.720067596879, 6226.066090086523, 6238.719257633508, 6243.37566243372, 6246.437820596168, 6337.651429171256, 6389.584676995981, 6390.744370225325, 6394.072859435449, 6398.616083035033, 5958.6424814511265, 6078.513718902565, 6080.604760690541, 6241.625502469867, 6249.843753906189], "unit": "score", "name": "prototype.html", "value": 4762.602085462729}, {"lowerIsBetter": false, "replicates": [753.58929383486, 763.2482005224849, 810.4245985350401, 888.6894075403951, 904.7240591619556, 13541.390637421315, 13547.051706380546, 13609.591712248624, 13683.726325473484, 13982.230977296258, 13084.280364579945, 14206.928965355159, 14217.0, 14240.0, 14276.714465710706, 832.2343444031491, 846.5640195299426, 847.6100993542977, 848.1010129263001, 848.3594885861166, 820.7414664380731, 832.6544484039147, 833.5790425834975, 833.6915341323719, 834.0116961400729, 866.5927014303268, 872.5549969515561, 872.7512658892217, 875.1860769484377, 875.8423483772918, 870.1255238485345, 870.6865528409799, 870.7561882672799, 870.7561882672893, 870.7823044238941, 643.6492111799081, 647.970841312142, 648.870225954811, 649.4933951517824, 649.5712829532486, 13326.533571325053, 13369.264690442022, 13379.397927093207, 13393.388289283594, 13413.195208287436, 12250.0, 12267.69330766729, 12347.19743216688, 12403.441845116991, 12564.05769567277, 10694.625688100958, 10829.0, 10870.61952831655, 10987.835182472269, 11318.434078296135, 3783.6000679748668, 3786.337390956599, 3801.448789925473, 3877.7479463835043, 3933.370660694275, 44084.338734919, 47894.0, 51341.22988155181, 54141.45858541404, 54416.455835441535, 11256.0, 11352.375619341015, 11448.713782155513, 11482.770344593062, 11568.190226684052, 19062.428127156207, 19300.613987720168, 19313.90343048276, 19322.516937076685, 19328.903355483133, 8337.0, 8454.0, 8532.189442003, 8558.572071396406, 8687.305015598737, 4642.442906851199, 4764.928526072112, 4782.808687652525, 4838.371011768518, 4952.603791696655, 3358.0, 3376.240345922197, 3380.3408335374857, 3384.0693809202667, 3385.6952874241438, 599.5743022454019, 610.2585358789092, 613.1814028272217, 619.3125630550086, 621.6363427394934, 690.9930900691029, 696.7944456385378, 785.1206648553657, 791.4538968111984, 799.4363973398856, 9683.370580912218, 9783.755406114904, 9793.853092203623, 9805.705828825146, 9918.900810991941, 627.2504357293083, 732.9230430804795, 741.355021131619, 784.3568274015253, 804.9315808156255, 4415.558444155623, 4434.290513517822, 4438.152962756221, 4520.660950428731, 4626.190416677068, 61105.69447152736, 61960.0, 62483.687581561804, 62714.686426567576, 62768.686156568925, 45849.54150458453, 56024.71987640117, 57907.42092579105, 60531.0, 61246.38753612407, 50455.0, 50905.23642145371, 50955.23567146496, 51248.0, 51776.74111629418, 9765.462899540309, 9944.403335799876, 10059.446730429603, 10059.647912323033, 10146.985301469795, 36609.267814643026, 38982.0, 39464.80267598644, 40405.595944040186, 40693.79653101834, 48703.5129648699, 50576.49423505865, 50604.74697626488, 51519.74240128775, 51624.0, 12902.741945161231, 13114.540991065267, 13154.736905262032, 13403.597892063253, 13676.726465470834, 12879.162854414433, 12983.870161298266, 13366.0, 13570.525031623845, 13691.178529288274, 13005.284709340698, 13494.12288201303, 13868.86131138716, 13977.091489053179, 14008.789868151782, 13183.14309569875, 13493.730125397633, 13935.233562153773, 14082.577522674335, 14174.716505670036, 12721.872781272068, 13080.149790263602, 13274.668133296746, 13300.135491193041, 13515.189088654712, 10475.52860121281, 10649.0, 10896.128309735044, 10941.0, 11062.0, 11184.601330810608, 11256.83114753263, 11356.148288878532, 11388.373639449579, 11465.369404682822], "unit": "score", "name": "yui.html", "value": 6909.555902010653}], "name": "dromaeo_css", "value": 7235.589430440605}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 109.0, 110.0, 110.0, 100.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 156.0, 163.0, 127.0, 165.0, 160.0, 124.0, 167.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [376.0, 376.0, 379.0, 374.0, 377.0, 378.0, 378.0, 378.0, 377.0, 375.0], "unit": "score", "name": "audio-dft", "value": 376.8}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 164.0, 75.0, 77.0, 83.0, 74.0, 163.0, 74.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 145.0, 92.0, 94.0, 93.0, 143.0, 92.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [192.0, 193.0, 192.0, 192.0, 192.0, 192.0, 192.0, 192.0, 192.0, 192.0], "unit": "score", "name": "imaging-darkroom", "value": 192.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 56.0, 58.0, 57.0, 61.0, 56.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.0}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 78.0, 85.0, 77.0, 78.0, 77.0, 77.0, 88.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 109.0, 109.0, 116.0, 119.0, 108.0, 119.0, 109.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.3}, {"lowerIsBetter": true, "replicates": [144.0, 142.0, 143.0, 143.0, 145.0, 135.0, 141.0, 153.0, 141.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 63.0, 63.0, 62.0, 62.0, 66.0, 64.0, 63.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1753.8}]} 19:38:01 INFO - Return code: 0 19:38:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:38:01 ERROR - # TBPL SUCCESS # 19:38:01 INFO - Running post-action listener: _resource_record_post_action 19:38:01 INFO - Running post-run listener: _resource_record_post_run 19:38:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 533569536; Read time: 628; Write time: 866124 19:38:02 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 242356224; Read time: 336; Write time: 474588 19:38:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291098624; Read time: 292; Write time: 391536 19:38:02 INFO - Running post-run listener: _upload_blobber_files 19:38:02 INFO - Blob upload gear active. 19:38:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:38:02 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 19:38:02 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'] 19:38:02 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 19:38:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:38:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:38:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:03 INFO - (blobuploader) - INFO - Done attempting. 19:38:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:38:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:04 INFO - (blobuploader) - INFO - Done attempting. 19:38:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:04 INFO - Return code: 0 19:38:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:38:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c36c2022601e91885d6fd18a4af6aae6455ba0a34a4df92b7b31864861f1b0bfd410c3273b6627ee8472673457f22507c8f1045f93d0a5112e35bb6ad654883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b67f6de824d4bfabdad58d475ed7898e749aa08c5eb38cf2af48b37854a5bb4c4a58ca8e6fb11c3c285c161f77e3713b1e5da22ef824980eb8ace338545ebb"} 19:38:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:38:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:38:04 INFO - Contents: 19:38:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c36c2022601e91885d6fd18a4af6aae6455ba0a34a4df92b7b31864861f1b0bfd410c3273b6627ee8472673457f22507c8f1045f93d0a5112e35bb6ad654883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b67f6de824d4bfabdad58d475ed7898e749aa08c5eb38cf2af48b37854a5bb4c4a58ca8e6fb11c3c285c161f77e3713b1e5da22ef824980eb8ace338545ebb"} 19:38:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:04 INFO - Copying logs to upload dir... 19:38:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:38:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.636363 ========= master_lag: 1.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-13 19:38:05.711443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 19:38:05.719037) ========= 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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c36c2022601e91885d6fd18a4af6aae6455ba0a34a4df92b7b31864861f1b0bfd410c3273b6627ee8472673457f22507c8f1045f93d0a5112e35bb6ad654883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b67f6de824d4bfabdad58d475ed7898e749aa08c5eb38cf2af48b37854a5bb4c4a58ca8e6fb11c3c285c161f77e3713b1e5da22ef824980eb8ace338545ebb"} build_url:https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/WTMk6bIcSsGR9hv6RKSQ9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c36c2022601e91885d6fd18a4af6aae6455ba0a34a4df92b7b31864861f1b0bfd410c3273b6627ee8472673457f22507c8f1045f93d0a5112e35bb6ad654883", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b67f6de824d4bfabdad58d475ed7898e749aa08c5eb38cf2af48b37854a5bb4c4a58ca8e6fb11c3c285c161f77e3713b1e5da22ef824980eb8ace338545ebb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 19:38:05.744617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:38:05.745879) ========= 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=aa52b8aba932b19cc50b5275000001de-1457921840.662095-526670461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003311 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 19:38:05.792216) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 19:38:05.792522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 19:38:05.793476) ========= ========= Total master_lag: 1.50 =========