builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1458837337.16 results: success (0) buildid: 20160324065936 builduid: 9ed4186af88b45b7880e124ef5a3ba25 revision: 73efa9d61ae02f3dd977d34d9cd83af2e090822d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.158851) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.159358) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.159660) ========= 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006435 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.193885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.194155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.256052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.256341) ========= 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004687 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.315792) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.316067) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.316394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.316693) ========= 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 09:35:37-- 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% 65.6M=0s 2016-03-24 09:35:37 (65.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.442807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.443105) ========= 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022412 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.511838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.512137) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 73efa9d61ae02f3dd977d34d9cd83af2e090822d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 73efa9d61ae02f3dd977d34d9cd83af2e090822d --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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 09:35:38,060 truncating revision to first 12 chars 2016-03-24 09:35:38,060 Setting DEBUG logging. 2016-03-24 09:35:38,060 attempt 1/10 2016-03-24 09:35:38,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/73efa9d61ae0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 09:35:38,349 unpacking tar archive at: mozilla-aurora-73efa9d61ae0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.106381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.106743) ========= echo 73efa9d61ae02f3dd977d34d9cd83af2e090822d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'73efa9d61ae02f3dd977d34d9cd83af2e090822d'] 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 73efa9d61ae02f3dd977d34d9cd83af2e090822d program finished with exit code 0 elapsedTime=0.003945 script_repo_revision: '73efa9d61ae02f3dd977d34d9cd83af2e090822d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.155078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.155371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.166187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-24 09:35:38.166526) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:38 INFO - MultiFileLogger online at 20160324 09:35:38 in /builds/slave/test-pgo 09:35:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:35:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:35:38 INFO - {'append_to_log': False, 09:35:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:35:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:35:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:35:38 INFO - 'branch': 'Mozilla-Aurora', 09:35:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:38 INFO - 'config_files': ('talos/linux_config.py',), 09:35:38 INFO - 'default_actions': ('clobber', 09:35:38 INFO - 'read-buildbot-config', 09:35:38 INFO - 'download-and-extract', 09:35:38 INFO - 'populate-webroot', 09:35:38 INFO - 'create-virtualenv', 09:35:38 INFO - 'install', 09:35:38 INFO - 'run-tests'), 09:35:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:38 INFO - 'download_minidump_stackwalk': True, 09:35:38 INFO - 'download_symbols': 'ondemand', 09:35:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:38 INFO - 'installer_path': 'installer.exe', 09:35:38 INFO - 'log_level': 'info', 09:35:38 INFO - 'log_name': 'talos', 09:35:38 INFO - 'log_to_console': True, 09:35:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:38 INFO - 'opt_config_files': (), 09:35:38 INFO - 'pip_index': False, 09:35:38 INFO - 'sps_profile': False, 09:35:38 INFO - 'sps_profile_interval': 0, 09:35:38 INFO - 'suite': 'dromaeojs', 09:35:38 INFO - 'system_bits': '32', 09:35:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:38 INFO - 'title': 'talos-linux64-ix-032', 09:35:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:38 INFO - 'use_talos_json': True, 09:35:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:35:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:38 INFO - 'work_dir': 'build'} 09:35:38 INFO - ##### 09:35:38 INFO - ##### Running clobber step. 09:35:38 INFO - ##### 09:35:38 INFO - Running pre-action listener: _resource_record_pre_action 09:35:38 INFO - Running main action method: clobber 09:35:38 INFO - rmtree: /builds/slave/test-pgo/build 09:35:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:35:39 INFO - Running post-action listener: _resource_record_post_action 09:35:39 INFO - ##### 09:35:39 INFO - ##### Running read-buildbot-config step. 09:35:39 INFO - ##### 09:35:39 INFO - Running pre-action listener: _resource_record_pre_action 09:35:39 INFO - Running main action method: read_buildbot_config 09:35:39 INFO - Using buildbot properties: 09:35:39 INFO - { 09:35:39 INFO - "project": "", 09:35:39 INFO - "product": "firefox", 09:35:39 INFO - "script_repo_revision": "production", 09:35:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:35:39 INFO - "repository": "", 09:35:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:35:39 INFO - "buildid": "20160324065936", 09:35:39 INFO - "pgo_build": "True", 09:35:39 INFO - "basedir": "/builds/slave/test-pgo", 09:35:39 INFO - "buildnumber": 372, 09:35:39 INFO - "slavename": "talos-linux64-ix-032", 09:35:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:35:39 INFO - "platform": "ubuntu64_hw", 09:35:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:35:39 INFO - "branch": "mozilla-aurora", 09:35:39 INFO - "repo_path": "releases/mozilla-aurora", 09:35:39 INFO - "revision": "73efa9d61ae02f3dd977d34d9cd83af2e090822d", 09:35:39 INFO - "stage_platform": "linux64-pgo", 09:35:39 INFO - "builduid": "9ed4186af88b45b7880e124ef5a3ba25", 09:35:39 INFO - "slavebuilddir": "test" 09:35:39 INFO - } 09:35:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:35:39 INFO - Running post-action listener: _resource_record_post_action 09:35:39 INFO - ##### 09:35:39 INFO - ##### Running download-and-extract step. 09:35:39 INFO - ##### 09:35:39 INFO - Running pre-action listener: _resource_record_pre_action 09:35:39 INFO - Running main action method: download_and_extract 09:35:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:35: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')]} 09:35:39 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:35:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:35:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:35:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:35:40 INFO - Downloaded 1448 bytes. 09:35:40 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:35:40 INFO - Using the following test package requirements: 09:35:40 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:35:40 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:40 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:35:40 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'jsshell-linux-x86_64.zip'], 09:35:40 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:40 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:35:40 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:35:40 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:35:40 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:40 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:35:40 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35: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')]} 09:35:40 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:35:42 INFO - Downloaded 23310137 bytes. 09:35:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:35:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:35:43 INFO - Return code: 0 09:35:43 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:43 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:35:44 INFO - Downloaded 23310137 bytes. 09:35:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:35:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:35:46 INFO - Return code: 0 09:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:46 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:35:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:35:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:35:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:35:48 INFO - Downloaded 10845161 bytes. 09:35:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:35:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:35:48 INFO - Return code: 0 09:35: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')]} 09:35:48 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:35:50 INFO - Downloaded 60448260 bytes. 09:35:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:35:50 INFO - mkdir: /builds/slave/test-pgo/properties 09:35:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:35:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:35:50 INFO - Contents: 09:35:50 INFO - build_url:https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:35:51 INFO - Running post-action listener: _resource_record_post_action 09:35:51 INFO - Running post-action listener: set_extra_try_arguments 09:35:51 INFO - ##### 09:35:51 INFO - ##### Running populate-webroot step. 09:35:51 INFO - ##### 09:35:51 INFO - Running pre-action listener: _resource_record_pre_action 09:35:51 INFO - Running main action method: populate_webroot 09:35:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:51 INFO - '--tppagecycles', 09:35:51 INFO - '7'], 09:35:51 INFO - 'tests': ['tsvgm']}}, 09:35:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:35:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:35:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'tests': ['damp', 'tps']}, 09:35:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['damp', 'tps']}, 09:35:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:35:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:51 INFO - 'other': {'tests': ['a11yr', 09:35:51 INFO - 'ts_paint', 09:35:51 INFO - 'tpaint', 09:35:51 INFO - 'sessionrestore', 09:35:51 INFO - 'sessionrestore_no_auto_restore', 09:35:51 INFO - 'tabpaint']}, 09:35:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['a11yr', 09:35:51 INFO - 'ts_paint', 09:35:51 INFO - 'tpaint', 09:35:51 INFO - 'sessionrestore', 09:35:51 INFO - 'sessionrestore_no_auto_restore', 09:35:51 INFO - 'tabpaint']}, 09:35:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['a11yr', 09:35:51 INFO - 'ts_paint', 09:35:51 INFO - 'tpaint', 09:35:51 INFO - 'sessionrestore', 09:35:51 INFO - 'sessionrestore_no_auto_restore', 09:35:51 INFO - 'tabpaint']}, 09:35:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['a11yr', 09:35:51 INFO - 'ts_paint', 09:35:51 INFO - 'tpaint', 09:35:51 INFO - 'sessionrestore', 09:35:51 INFO - 'sessionrestore_no_auto_restore', 09:35:51 INFO - 'tabpaint']}, 09:35:51 INFO - 'other_l64': {'tests': ['a11yr', 09:35:51 INFO - 'ts_paint', 09:35:51 INFO - 'tpaint', 09:35:51 INFO - 'sessionrestore', 09:35:51 INFO - 'sessionrestore_no_auto_restore', 09:35:51 INFO - 'tabpaint']}, 09:35:51 INFO - 'other_nol64': {'tests': ['a11yr', 09:35:51 INFO - 'ts_paint', 09:35:51 INFO - 'tpaint', 09:35:51 INFO - 'sessionrestore', 09:35:51 INFO - 'sessionrestore_no_auto_restore', 09:35:51 INFO - 'tabpaint']}, 09:35:51 INFO - 'svgr': {'tests': ['tsvgx', 09:35:51 INFO - 'tsvgr_opacity', 09:35:51 INFO - 'tart', 09:35:51 INFO - 'tscrollx', 09:35:51 INFO - 'cart']}, 09:35:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['tsvgx', 09:35:51 INFO - 'tsvgr_opacity', 09:35:51 INFO - 'tart', 09:35:51 INFO - 'tscrollx', 09:35:51 INFO - 'cart']}, 09:35:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'tests': ['tp5o']}, 09:35:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'talos_options': ['--e10s'], 09:35:51 INFO - 'tests': ['tp5o']}, 09:35:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'talos_options': ['--xperf_path', 09:35:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:51 INFO - 'tests': ['tp5n']}, 09:35:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:51 INFO - 'talos_options': ['--e10s', 09:35:51 INFO - '--xperf_path', 09:35:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:51 INFO - 'tests': ['tp5n']}}, 09:35:51 INFO - 'talos.zip': {'path': '', 09:35:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:51 INFO - Running post-action listener: _resource_record_post_action 09:35:51 INFO - ##### 09:35:51 INFO - ##### Running create-virtualenv step. 09:35:51 INFO - ##### 09:35:51 INFO - Running pre-action listener: _resource_record_pre_action 09:35:51 INFO - Running main action method: create_virtualenv 09:35:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:35:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:35:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:35:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:51 INFO - Using real prefix '/usr' 09:35:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:35:52 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:54 INFO - Installing pip.................done. 09:35:54 INFO - Return code: 0 09:35:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:54 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 09:35:54 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 09:35:54 INFO - Using env: {'DISPLAY': ':0', 09:35:54 INFO - 'HOME': '/home/cltbld', 09:35:54 INFO - 'LANG': 'en_US.UTF-8', 09:35:54 INFO - 'LANGUAGE': 'en_US:en', 09:35:54 INFO - 'LOGNAME': 'cltbld', 09:35:54 INFO - 'MAIL': '/var/mail/cltbld', 09:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:54 INFO - 'MOZ_NO_REMOTE': '1', 09:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:54 INFO - 'NO_EM_RESTART': '1', 09:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:35:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:35:54 INFO - 'SHELL': '/bin/bash', 09:35:54 INFO - 'SHLVL': '1', 09:35:54 INFO - 'TERM': 'linux', 09:35:54 INFO - 'TMOUT': '86400', 09:35:54 INFO - 'USER': 'cltbld', 09:35:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:54 INFO - '_': '/tools/buildbot/bin/python'} 09:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:35:54 INFO - Cleaning up... 09:35:54 INFO - Return code: 0 09:35:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:54 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:54 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 09:35:54 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 09:35:54 INFO - Using env: {'DISPLAY': ':0', 09:35:54 INFO - 'HOME': '/home/cltbld', 09:35:54 INFO - 'LANG': 'en_US.UTF-8', 09:35:54 INFO - 'LANGUAGE': 'en_US:en', 09:35:54 INFO - 'LOGNAME': 'cltbld', 09:35:54 INFO - 'MAIL': '/var/mail/cltbld', 09:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:54 INFO - 'MOZ_NO_REMOTE': '1', 09:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:54 INFO - 'NO_EM_RESTART': '1', 09:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:35:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:35:54 INFO - 'SHELL': '/bin/bash', 09:35:54 INFO - 'SHLVL': '1', 09:35:54 INFO - 'TERM': 'linux', 09:35:54 INFO - 'TMOUT': '86400', 09:35:54 INFO - 'USER': 'cltbld', 09:35:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:54 INFO - '_': '/tools/buildbot/bin/python'} 09:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:54 INFO - Downloading/unpacking psutil>=0.7.1 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:56 INFO - Installing collected packages: psutil 09:35:56 INFO - Running setup.py install for psutil 09:35:57 INFO - building 'psutil._psutil_linux' extension 09:35:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:35:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:35:57 INFO - building 'psutil._psutil_posix' extension 09:35:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:35:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:35:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:57 INFO - Successfully installed psutil 09:35:57 INFO - Cleaning up... 09:35:57 INFO - Return code: 0 09:35:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:57 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:57 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 09:35:57 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 09:35:57 INFO - Using env: {'DISPLAY': ':0', 09:35:57 INFO - 'HOME': '/home/cltbld', 09:35:57 INFO - 'LANG': 'en_US.UTF-8', 09:35:57 INFO - 'LANGUAGE': 'en_US:en', 09:35:57 INFO - 'LOGNAME': 'cltbld', 09:35:57 INFO - 'MAIL': '/var/mail/cltbld', 09:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:57 INFO - 'MOZ_NO_REMOTE': '1', 09:35:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:57 INFO - 'NO_EM_RESTART': '1', 09:35:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:35:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:35:57 INFO - 'SHELL': '/bin/bash', 09:35:57 INFO - 'SHLVL': '1', 09:35:57 INFO - 'TERM': 'linux', 09:35:57 INFO - 'TMOUT': '86400', 09:35:57 INFO - 'USER': 'cltbld', 09:35:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:57 INFO - '_': '/tools/buildbot/bin/python'} 09:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:36:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:36:00 INFO - Installing collected packages: mozsystemmonitor 09:36:00 INFO - Running setup.py install for mozsystemmonitor 09:36:00 INFO - Successfully installed mozsystemmonitor 09:36:00 INFO - Cleaning up... 09:36:00 INFO - Return code: 0 09:36:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:00 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:00 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 09:36:00 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 09:36:00 INFO - Using env: {'DISPLAY': ':0', 09:36:00 INFO - 'HOME': '/home/cltbld', 09:36:00 INFO - 'LANG': 'en_US.UTF-8', 09:36:00 INFO - 'LANGUAGE': 'en_US:en', 09:36:00 INFO - 'LOGNAME': 'cltbld', 09:36:00 INFO - 'MAIL': '/var/mail/cltbld', 09:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:00 INFO - 'MOZ_NO_REMOTE': '1', 09:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:00 INFO - 'NO_EM_RESTART': '1', 09:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:00 INFO - 'SHELL': '/bin/bash', 09:36:00 INFO - 'SHLVL': '1', 09:36:00 INFO - 'TERM': 'linux', 09:36:00 INFO - 'TMOUT': '86400', 09:36:00 INFO - 'USER': 'cltbld', 09:36:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:00 INFO - '_': '/tools/buildbot/bin/python'} 09:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:36:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:03 INFO - Downloading docopt-0.6.1.tar.gz 09:36:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:03 INFO - Running setup.py install for blobuploader 09:36:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:36:03 INFO - Running setup.py install for requests 09:36:03 INFO - Running setup.py install for docopt 09:36:04 INFO - Successfully installed blobuploader requests docopt 09:36:04 INFO - Cleaning up... 09:36:04 INFO - Return code: 0 09:36:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36: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')]} 09:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:04 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:04 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 09:36:04 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 09:36:04 INFO - Using env: {'DISPLAY': ':0', 09:36:04 INFO - 'HOME': '/home/cltbld', 09:36:04 INFO - 'LANG': 'en_US.UTF-8', 09:36:04 INFO - 'LANGUAGE': 'en_US:en', 09:36:04 INFO - 'LOGNAME': 'cltbld', 09:36:04 INFO - 'MAIL': '/var/mail/cltbld', 09:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:04 INFO - 'MOZ_NO_REMOTE': '1', 09:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:04 INFO - 'NO_EM_RESTART': '1', 09:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:04 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:04 INFO - 'SHELL': '/bin/bash', 09:36:04 INFO - 'SHLVL': '1', 09:36:04 INFO - 'TERM': 'linux', 09:36:04 INFO - 'TMOUT': '86400', 09:36:04 INFO - 'USER': 'cltbld', 09:36:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:04 INFO - '_': '/tools/buildbot/bin/python'} 09:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:04 INFO - Running setup.py (path:/tmp/pip-oo58lE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:04 INFO - Running setup.py (path:/tmp/pip-lgwZ2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:04 INFO - Running setup.py (path:/tmp/pip-YOUgCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:04 INFO - Running setup.py (path:/tmp/pip-97hbHW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:04 INFO - Running setup.py (path:/tmp/pip-FA3RAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:04 INFO - Running setup.py (path:/tmp/pip-Ygwsx8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:04 INFO - Running setup.py (path:/tmp/pip-H2r11h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:04 INFO - Running setup.py (path:/tmp/pip-4eDIuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:04 INFO - Running setup.py (path:/tmp/pip-EJg5mV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:05 INFO - Running setup.py (path:/tmp/pip-Qsel3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:05 INFO - Running setup.py (path:/tmp/pip-jSYdV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:05 INFO - Running setup.py (path:/tmp/pip-Rh2nBc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:05 INFO - Running setup.py (path:/tmp/pip-WC3wrs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:05 INFO - Running setup.py (path:/tmp/pip-L8yf9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:05 INFO - Running setup.py (path:/tmp/pip-yJBk5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:05 INFO - Running setup.py (path:/tmp/pip-cK_5IZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:05 INFO - Running setup.py (path:/tmp/pip-09m8Vj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:05 INFO - Running setup.py install for manifestparser 09:36:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Running setup.py install for mozcrash 09:36:05 INFO - Running setup.py install for mozdebug 09:36:05 INFO - Running setup.py install for mozdevice 09:36:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozfile 09:36:06 INFO - Running setup.py install for mozhttpd 09:36:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozinfo 09:36:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozInstall 09:36:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozleak 09:36:06 INFO - Running setup.py install for mozlog 09:36:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for moznetwork 09:36:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozprocess 09:36:06 INFO - Running setup.py install for mozprofile 09:36:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozrunner 09:36:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:36:07 INFO - Running setup.py install for mozscreenshot 09:36:07 INFO - Running setup.py install for moztest 09:36:07 INFO - Running setup.py install for mozversion 09:36:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:36:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:07 INFO - Cleaning up... 09:36:07 INFO - Return code: 0 09:36:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:07 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:07 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 09:36:07 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 09:36:07 INFO - Using env: {'DISPLAY': ':0', 09:36:07 INFO - 'HOME': '/home/cltbld', 09:36:07 INFO - 'LANG': 'en_US.UTF-8', 09:36:07 INFO - 'LANGUAGE': 'en_US:en', 09:36:07 INFO - 'LOGNAME': 'cltbld', 09:36:07 INFO - 'MAIL': '/var/mail/cltbld', 09:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:07 INFO - 'MOZ_NO_REMOTE': '1', 09:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:07 INFO - 'NO_EM_RESTART': '1', 09:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:07 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:07 INFO - 'SHELL': '/bin/bash', 09:36:07 INFO - 'SHLVL': '1', 09:36:07 INFO - 'TERM': 'linux', 09:36:07 INFO - 'TMOUT': '86400', 09:36:07 INFO - 'USER': 'cltbld', 09:36:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:07 INFO - '_': '/tools/buildbot/bin/python'} 09:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:07 INFO - Running setup.py (path:/tmp/pip-3bWou0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:07 INFO - Running setup.py (path:/tmp/pip-eqdvQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:07 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)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:07 INFO - Running setup.py (path:/tmp/pip-HEcFjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:07 INFO - Running setup.py (path:/tmp/pip-bcdaW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:07 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)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:07 INFO - Running setup.py (path:/tmp/pip-EGsPKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:07 INFO - Running setup.py (path:/tmp/pip-rgZviO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:08 INFO - Running setup.py (path:/tmp/pip-duUO08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:08 INFO - Running setup.py (path:/tmp/pip-Qmzzin-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:08 INFO - Running setup.py (path:/tmp/pip-RA9MXO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:08 INFO - Running setup.py (path:/tmp/pip-53Hw1H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:08 INFO - Running setup.py (path:/tmp/pip-1WpaHa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:08 INFO - Running setup.py (path:/tmp/pip-osnEpV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:08 INFO - Running setup.py (path:/tmp/pip-12qTFG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:08 INFO - Running setup.py (path:/tmp/pip-0ecnwK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:08 INFO - Running setup.py (path:/tmp/pip-K17Uvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:08 INFO - Running setup.py (path:/tmp/pip-JslKvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:08 INFO - Running setup.py (path:/tmp/pip-QfwKIe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:36:08 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)) 09:36:08 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)) 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:08 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)) 09:36:08 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)) 09:36:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:11 INFO - Downloading blessings-1.6.tar.gz 09:36:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:11 INFO - Installing collected packages: blessings 09:36:11 INFO - Running setup.py install for blessings 09:36:11 INFO - Successfully installed blessings 09:36:11 INFO - Cleaning up... 09:36:11 INFO - Return code: 0 09:36:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:36:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:11 INFO - Reading from file tmpfile_stdout 09:36:11 INFO - Current package versions: 09:36:11 INFO - argparse == 1.2.1 09:36:11 INFO - blessings == 1.6 09:36:11 INFO - blobuploader == 1.2.4 09:36:11 INFO - docopt == 0.6.1 09:36:11 INFO - manifestparser == 1.1 09:36:11 INFO - mozInstall == 1.12 09:36:11 INFO - mozcrash == 0.17 09:36:11 INFO - mozdebug == 0.1 09:36:11 INFO - mozdevice == 0.48 09:36:11 INFO - mozfile == 1.2 09:36:11 INFO - mozhttpd == 0.7 09:36:11 INFO - mozinfo == 0.9 09:36:11 INFO - mozleak == 0.1 09:36:11 INFO - mozlog == 3.1 09:36:11 INFO - moznetwork == 0.27 09:36:11 INFO - mozprocess == 0.22 09:36:11 INFO - mozprofile == 0.28 09:36:11 INFO - mozrunner == 6.11 09:36:11 INFO - mozscreenshot == 0.1 09:36:11 INFO - mozsystemmonitor == 0.0 09:36:11 INFO - moztest == 0.7 09:36:11 INFO - mozversion == 1.4 09:36:11 INFO - psutil == 3.1.1 09:36:11 INFO - requests == 1.2.3 09:36:11 INFO - wsgiref == 0.1.2 09:36:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:11 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 09:36:11 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 09:36:11 INFO - Using env: {'DISPLAY': ':0', 09:36:11 INFO - 'HOME': '/home/cltbld', 09:36:11 INFO - 'LANG': 'en_US.UTF-8', 09:36:11 INFO - 'LANGUAGE': 'en_US:en', 09:36:11 INFO - 'LOGNAME': 'cltbld', 09:36:11 INFO - 'MAIL': '/var/mail/cltbld', 09:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:11 INFO - 'MOZ_NO_REMOTE': '1', 09:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:11 INFO - 'NO_EM_RESTART': '1', 09:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:11 INFO - 'SHELL': '/bin/bash', 09:36:11 INFO - 'SHLVL': '1', 09:36:11 INFO - 'TERM': 'linux', 09:36:11 INFO - 'TMOUT': '86400', 09:36:11 INFO - 'USER': 'cltbld', 09:36:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:11 INFO - '_': '/tools/buildbot/bin/python'} 09:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:36:11 INFO - Cleaning up... 09:36:11 INFO - Return code: 0 09:36:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:11 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 09:36:11 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 09:36:11 INFO - Using env: {'DISPLAY': ':0', 09:36:11 INFO - 'HOME': '/home/cltbld', 09:36:11 INFO - 'LANG': 'en_US.UTF-8', 09:36:11 INFO - 'LANGUAGE': 'en_US:en', 09:36:11 INFO - 'LOGNAME': 'cltbld', 09:36:11 INFO - 'MAIL': '/var/mail/cltbld', 09:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:11 INFO - 'MOZ_NO_REMOTE': '1', 09:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:11 INFO - 'NO_EM_RESTART': '1', 09:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:11 INFO - 'SHELL': '/bin/bash', 09:36:11 INFO - 'SHLVL': '1', 09:36:11 INFO - 'TERM': 'linux', 09:36:11 INFO - 'TMOUT': '86400', 09:36:11 INFO - 'USER': 'cltbld', 09:36:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:11 INFO - '_': '/tools/buildbot/bin/python'} 09:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:12 INFO - Downloading/unpacking jsonschema 09:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:14 INFO - Downloading/unpacking functools32 (from jsonschema) 09:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:14 INFO - warning: no files found matching '*.txt' 09:36:14 INFO - no previously-included directories found matching 'build' 09:36:14 INFO - no previously-included directories found matching 'dist' 09:36:14 INFO - no previously-included directories found matching '.git*' 09:36:14 INFO - Installing collected packages: jsonschema, functools32 09:36:14 INFO - Running setup.py install for functools32 09:36:14 INFO - warning: no files found matching '*.txt' 09:36:14 INFO - no previously-included directories found matching 'build' 09:36:14 INFO - no previously-included directories found matching 'dist' 09:36:14 INFO - no previously-included directories found matching '.git*' 09:36:14 INFO - Successfully installed jsonschema functools32 09:36:14 INFO - Cleaning up... 09:36:14 INFO - Return code: 0 09:36:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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 0x7fb192117f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, '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': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:14 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 09:36:14 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 09:36:14 INFO - Using env: {'DISPLAY': ':0', 09:36:14 INFO - 'HOME': '/home/cltbld', 09:36:14 INFO - 'LANG': 'en_US.UTF-8', 09:36:14 INFO - 'LANGUAGE': 'en_US:en', 09:36:14 INFO - 'LOGNAME': 'cltbld', 09:36:14 INFO - 'MAIL': '/var/mail/cltbld', 09:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:14 INFO - 'MOZ_NO_REMOTE': '1', 09:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:14 INFO - 'NO_EM_RESTART': '1', 09:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:14 INFO - 'SHELL': '/bin/bash', 09:36:14 INFO - 'SHLVL': '1', 09:36:14 INFO - 'TERM': 'linux', 09:36:14 INFO - 'TMOUT': '86400', 09:36:14 INFO - 'USER': 'cltbld', 09:36:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:14 INFO - '_': '/tools/buildbot/bin/python'} 09:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:15 INFO - Downloading/unpacking flake8 09:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:36:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:36:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:36:18 INFO - no previously-included directories found matching 'docs/_build' 09:36:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:36:18 INFO - Running setup.py install for pep8 09:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:36:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:36:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:36:18 INFO - no previously-included directories found matching 'docs/_build' 09:36:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:36:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:36:18 INFO - Cleaning up... 09:36:18 INFO - Return code: 0 09:36:18 INFO - Running post-action listener: _resource_record_post_action 09:36:18 INFO - Running post-action listener: _start_resource_monitoring 09:36:18 INFO - Starting resource monitoring. 09:36:18 INFO - ##### 09:36:18 INFO - ##### Running install step. 09:36:18 INFO - ##### 09:36:18 INFO - Running pre-action listener: _resource_record_pre_action 09:36:18 INFO - Running main action method: install 09:36:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:19 INFO - Reading from file tmpfile_stdout 09:36:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:36:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:36:19 INFO - Reading from file tmpfile_stdout 09:36:19 INFO - Output received: 09:36:19 INFO - Usage: mozinstall [options] installer 09:36:19 INFO - Options: 09:36:19 INFO - -h, --help show this help message and exit 09:36:19 INFO - -d DEST, --destination=DEST 09:36:19 INFO - Directory to install application into. [default: 09:36:19 INFO - "/builds/slave/test-pgo"] 09:36:19 INFO - --app=APP Application being installed. [default: firefox] 09:36:19 INFO - mkdir: /builds/slave/test-pgo/build/application 09:36:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:36:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:36:35 INFO - Reading from file tmpfile_stdout 09:36:35 INFO - Output received: 09:36:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:36:35 INFO - Running post-action listener: _resource_record_post_action 09:36:35 INFO - ##### 09:36:35 INFO - ##### Running run-tests step. 09:36:35 INFO - ##### 09:36:35 INFO - Running pre-action listener: _resource_record_pre_action 09:36:35 INFO - Running main action method: run_tests 09:36:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:36:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:36:35 INFO - Python 2.7.3 09:36:35 INFO - Return code: 0 09:36:35 INFO - grabbing minidump binary from tooltool 09:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:35 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 0x110e920>, '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 0x110f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110fcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:36:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:36:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:36:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:35 INFO - Return code: 0 09:36:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:36:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:36:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:36:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:36:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:36:36 INFO - Return code: 0 09:36:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 09:36:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 09:36:36 INFO - Using env: {'DISPLAY': ':0', 09:36:36 INFO - 'HOME': '/home/cltbld', 09:36:36 INFO - 'LANG': 'en_US.UTF-8', 09:36:36 INFO - 'LANGUAGE': 'en_US:en', 09:36:36 INFO - 'LOGNAME': 'cltbld', 09:36:36 INFO - 'MAIL': '/var/mail/cltbld', 09:36:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:36 INFO - 'MOZ_NO_REMOTE': '1', 09:36:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:36 INFO - 'NO_EM_RESTART': '1', 09:36:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:36:36 INFO - 'SHELL': '/bin/bash', 09:36:36 INFO - 'SHLVL': '1', 09:36:36 INFO - 'TERM': 'linux', 09:36:36 INFO - 'TMOUT': '86400', 09:36:36 INFO - 'USER': 'cltbld', 09:36:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1458837292.218187-157942928', 09:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:36 INFO - '_': '/tools/buildbot/bin/python'} 09:36:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 09:36:36 INFO - mozversion application_buildid: 20160324065936 09:36:36 INFO - mozversion application_changeset: 73efa9d61ae02f3dd977d34d9cd83af2e090822d 09:36:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:36:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:36 INFO - mozversion application_name: Firefox 09:36:36 INFO - mozversion application_remotingname: firefox-dev 09:36:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:36:36 INFO - mozversion application_vendor: Mozilla 09:36:36 INFO - mozversion application_version: 47.0a2 09:36:36 INFO - mozversion platform_buildid: 20160324065936 09:36:36 INFO - mozversion platform_changeset: 73efa9d61ae02f3dd977d34d9cd83af2e090822d 09:36:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:36:36 INFO - mozversion platform_version: 47.0a2 09:36:36 INFO - using testdate: 1458837396 09:36:36 INFO - actual date: 1458837396 09:36:36 INFO - starting webserver on 'localhost:59420' 09:36:36 INFO - SUITE-START | Running 2 tests 09:36:36 INFO - TEST-START | dromaeo_css 09:36:36 INFO - operating with platform_type : linux_ 09:36:36 INFO - Initialising browser for dromaeo_css test... 09:36:36 INFO - TEST-INFO | started process 17893 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2ZgoX4/profile http://localhost:59420/getInfo.html) 09:36:41 INFO - PROCESS | 17893 | __metrics Screen width/height:1600/1200 09:36:41 INFO - PROCESS | 17893 | colorDepth:24 09:36:41 INFO - PROCESS | 17893 | Browser inner width/height: 1024/697 09:36:41 INFO - PROCESS | 17893 | __metrics 09:36:42 INFO - PROCESS | 17893 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:43 INFO - TEST-INFO | 17893: exit 0 09:36:43 INFO - Browser initialized. 09:36:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:43 INFO - TEST-INFO | started process 17980 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2ZgoX4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:55 INFO - PROCESS | 17980 | RSS: Main: 144318464 09:36:55 INFO - PROCESS | 17980 | 09:37:46 INFO - PROCESS | 17980 | 1458837466466 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:39:54 INFO - PROCESS | 17980 | Cycle 1(1): loaded http://localhost:59420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59420/tests/dromaeo/cssquery-ext.html) 09:39:55 INFO - PROCESS | 17980 | RSS: Main: 249069568 09:39:55 INFO - PROCESS | 17980 | 09:42:57 INFO - PROCESS | 17980 | Cycle 1(1): loaded http://localhost:59420/tests/dromaeo/cssquery-ext.html (next: http://localhost:59420/tests/dromaeo/cssquery-jquery.html) 09:42:58 INFO - PROCESS | 17980 | RSS: Main: 227799040 09:42:58 INFO - PROCESS | 17980 | 09:46:00 INFO - PROCESS | 17980 | Cycle 1(1): loaded http://localhost:59420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59420/tests/dromaeo/cssquery-mootools.html) 09:46:00 INFO - PROCESS | 17980 | RSS: Main: 232685568 09:46:00 INFO - PROCESS | 17980 | 09:49:02 INFO - PROCESS | 17980 | Cycle 1(1): loaded http://localhost:59420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59420/tests/dromaeo/cssquery-prototype.html) 09:49:03 INFO - PROCESS | 17980 | RSS: Main: 205574144 09:49:03 INFO - PROCESS | 17980 | 09:52:05 INFO - PROCESS | 17980 | Cycle 1(1): loaded http://localhost:59420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59420/tests/dromaeo/cssquery-yui.html) 09:52:06 INFO - PROCESS | 17980 | RSS: Main: 210305024 09:52:06 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | Cycle 1(1): loaded http://localhost:59420/tests/dromaeo/cssquery-yui.html (next: http://localhost:59420/tests/dromaeo/cssquery-dojo.html) 09:55:08 INFO - PROCESS | 17980 | RSS: Main: 255451136 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | __start_tp_report 09:55:08 INFO - PROCESS | 17980 | _x_x_mozilla_page_load 09:55:08 INFO - PROCESS | 17980 | _x_x_mozilla_page_load_details 09:55:08 INFO - PROCESS | 17980 | |i|pagename|runs| 09:55:08 INFO - PROCESS | 17980 | |0;dojo.html;3243.56211911392;3281.1633033576436;3301.537784710141;3301.900942971709;3334.799912005279;5297.814576489824;5309.30978972734;5323.0152421801995;5324.227986941901;5388.91916621251;5320.17537281721;5344.171653393721;5348.384935732392;5378.354597448311;5382.058139825534;4741.81032758691;4825.083234185511;4886.218205087187;4892.0705066037335;4933.531314525115;4813;4861.076395484846;4888.266759985995;4922.68002579833;4931.161702510564;4889.095517329305;4908.43552991407;4912.778924948386;4916.680415772981;4922.581580565657;4900.411950565919;4913.70781576343;4916.58209052231;4924.359833221694;4943.357363542752;4796.592289655384;4796.904061918777;4837.7097374157665;4844.806207751686;4871.732054736988;5091.032703786269;5122.129238029506;5125.128728116192;5125.38495380553;5139.58883289336;5670.404607516234;5674.169935293701;5680.091185410314;5681.488666020078;5704.4865962063195;5493;5714.314282286111;5755.482006619424;5877.79427720032;5878.177055212273;5308.495692909168;5312.76092575835;5328.067588172094;5331.306930099062;5333.839984800462;5766.567507436959;5767.36558978512;5768.567357448208;5775.48020678141;5781.335146458127;5385.6230063895155;5629.8592535186945;5695.03184458643;5718.7426565804635;5739.512141467939;5756.079027355687;5760.74076666551;5765.567582431335;5766.279215098113;5773.018586840247;5579.944200558024;5751.827445176651;5753.3958934311295;5755.1367294906095;5756.222909907193;5679.6876171810945;5794.82615521535;5799.159121927297;5826.533877289807;5829.242198514251;4356.847510337123;4359.825606975749;4360.040791025969;4361.258586040381;4384.539623339567;3905.3946638271113;3912.5304963404005;3942.42834788954;3951.1110000249714;3964.960350396459;5366.91949620756;5375.838724838261;5385.299911011622;5390.784368625211;5410.458954104558;5673.687947162863;5674.744636491368;5675.744591493392;5687.715614219355;5699.116636921284;5222.060029194706;5301.390340110936;5383.650062745909;5411.161270003156;5419.403865574784;4941.876453088702;4955.380577427822;4960.751962401865;4962.727050012212;4970.577500912391;5863.208466857005;5881.617694849907;5886.23478947734;5888.411158884077;5923.022701254331;5545.279113715353;5730.8280751576685;5758.712064396847;5819.039858423313;5849.122631605123;5858.7070646466655;5862;5862.032764593965;5865.648061116347;5872.412758724094;5621.494065534122;5624.578156638187;5626.127950167731;5626.971865140648;5645.802396916252;5604.187392828098;5791.942080579141;5850.3857095006115;5856.4143585641095;5882.294124705063;5525.392206857162;5549.5837812165055;5550.250716153268;5557;5557.027520184032;5518.3377994639295;5555.333359996826;5555.972220138873;5559.833205003694;5573.470520300565;5527.226188333717;5588.720563971704;5592.608517403743;5608.691521966168;5636.408177141505;5522.806701765419;5542.889142217214;5544.611877168721;5544.63959842609;5581.162825576033;5431.6740995540395;5461;5491.203775452457;5495.313085864267;5497.230387745639 09:55:08 INFO - PROCESS | 17980 | |1;ext.html;528.656373357318;538.8545092824937;543.3045701502078;560.3919747074423;601.6781022153149;31188.99999999997;38159.618403815955;38771.41842872352;39005.41491877617;39032.60967390325;43517.78241108798;44185.7790711046;44213.557864421346;44317.113657726826;44319;7863.646135923868;9045.3668243223;9242.768930776718;10445.84331235032;10632.946835265813;10608.628697995571;10752.73118172048;10759.946200268987;10770;10772.73068173294;10724.946375268151;10804.5678172873;10808.945955270212;10838.295510791773;10839.783204335949;10718;10721.874203208668;10758.085562727178;10772.946135269274;10780.245382823205;10901.1279097672;11010.50452729629;11017.338959662366;11074.612388566362;11087.83368249477;43767.56232437667;44375;44394.55605443969;44497.55502444966;44509.554904451186;3652.2695460907926;3671.1556342041213;3695.575008873987;3752.6434988676033;4415.712978656409;29568.112956611338;29741.256468588243;29996.95010674616;30119;30885.38229235403;3813.866514671973;3896.6687831534355;3917.4907262056036;3922.7254092213557;4225.894352641178;298554;299128.99999999785;300836;301675;301948;44560.77719611381;45235;45249.095018099455;65565;65809;43982.78008609937;44141.33787993182;44171.337429938576;44208.778956105016;44222.33666495005;14790.556283311518;15358.769618455732;15704.057756534645;15837.445689400816;15887.364505419884;12453.06602004835;12518.248905065726;12553.623391298275;12554.309512976874;12567.434465449076;15044.247787610575;15241.704455121217;15306.770398444032;15312;15467.381304747683;5872.530197584183;5921.348651648315;5993.280806303184;6017.06735456005;6031.638101713911;907.2424525521131;1042.8070806900748;1070.6199299248653;1131.8698349689726;1235.184778046485;29646.258843529085;30128.849355753082;30183.849080754455;30780.076597702104;31222;1112.8831472695251;1143.5997400909782;1144.3362849547243;1152.3777160333327;1163.2613290560555;15826.525204243891;15972.76040859388;16136.515904522883;16148.83851161497;16416.917915410348;341891;346962;347003;348304;350351;57777.71111144417;58211;58842.7057864708;58914.41085589089;58929;1282.2819221236139;1442.35094207607;1457.3806132393902;1461.5030889497623;1476.1733429279639;27712.72287277182;27839;27997.580036299878;28546.429071418872;28701.569476458288;42930.78534607307;43579.12841743084;43652.56347436612;43686.126277474905;43699.34450983301;188740;227043;227235;228526;282586;33669;34365.828170858986;34787.478187826695;34897;35398;40742.59257407388;40897.591024090565;41400.79299603483;41703.374449382674;55798.721006394706;39778.20443591054;40362.12073678937;40584.188316234104;40905.18189636131;44177.11645767131;42625.786871065444;43178.568214317456;43257.13485730205;43438;43550.12899741924;42627.360589590564;43338;43626.78186609047;44228;44234;37854.242915142095;38277.80861095677;39348;39354.803225983684;40423.1915361697;30074.849625751733;30151;30443.543346849372;30445.39109217759;30540.389192215585 09:55:08 INFO - PROCESS | 17980 | |2;jquery.html;386.9090763670537;394.1860058978208;395.31412998447706;399.7201958628959;400.42938812192625;14100.224487653175;14274.64313392163;18627.534311642215;19348.51628709283;19362.225510979562;17980.370687025956;18063.18715657795;18173.7273940891;18261.63476730468;18281;5521.668699878;5709.971450142743;5719.227904232937;5723.771049158028;5730.799422020209;4163.937540936889;5590.133529302944;5978.641281523101;6226.501879849624;6242.406971337716;6151.815445536641;6188.84527886802;6218.253809542839;6218.813435596917;6221.377862213788;6154.661493617849;6163.229596300463;6164.969175154118;6165;6165.044418115177;5481.314835645544;5506;5506.889862202734;5509.421510741395;5511.4213007634025;21325.5734885303;21902.89048554763;22083.77916220833;22118.668219976713;22192.778072219233;2284.954300913989;2372.3594629450126;2377.7859992600747;2411.144043864438;2462.4090218347646;13315.40080696371;13735.313234338244;13952.372143253579;14138.164578394795;14187.361568729431;1937.225109956029;2010.3164923925935;2025.4126303372004;2028.5739994601151;2083.9895800521053;60023.09965350523;62257.37742622561;62384.68807655932;62626;64278.35721642771;10431.947840260902;10876.72808179786;11128.888711112948;11139.164562657834;11221.102311815035;14732.263386830615;14834.629134271514;14850.405983760744;14856.405743770345;14859.108453492825;7380.077490313711;7394;7461.1419686735635;7461.552306861606;7493.250674932572;7165.283471652793;7393.445491588152;7683.577403242875;7741.496802707806;7757;4919.262110683426;4982.626303027288;4993.725345106054;5009.549140577293;5048.596112311006;1949.483386902472;1979.0797279264923;1982.0684278389133;2002.2191345375315;2002.589469158819;797.7845981585056;906.0984320601044;967.690339091484;986.413084214891;1027.9383237005654;16650.333986640642;16828.915855420644;17950;18262.36081737133;18279.63440731178;950.4202436513721;989.3569180033036;990.8117457683018;1029.912457441126;1051.0960573906434;8724.563771811385;10339.793204136025;10375.792484150275;10416.531256093494;10576.15390768752;435149;443529;459568;465365;466164;76576;79653.60173199212;80293;80910.59544702356;82357.17642823615;1054.9156067514734;1073.9355638661705;1093.420487141832;1102.3330884814573;1105.9557617695364;16038.278277477308;16058.919705401866;16065.919670401574;16227.107509087113;16492.917535412726;34329.65670343264;34377.65622343744;34856.65143348635;35340.469892951114;35385.292294153456;46957.765211173726;50101.49898501114;50146.7492662549;50360.244596330354;50448.747756260986;7891.921080789119;7927.326177274997;7978.680852765824;7982.361411087215;8115.310198633182;11258.268212566158;11525.250858694159;11549.36478493691;11728.94135529317;11961.940190298992;10167.694969150938;10375.16998640122;10381.688549343531;10455.059044686015;10533;10136.695899123039;10159.593616255266;10308.639197628047;10434.947825261128;10461.215408844215;10423.11403530678;10601;10631.787364252517;10788.083012943987;11011.559537618405;7988.520688758693;8023.719169829028;8041.517508949481;8187.754367368989;8321.375896807642;9960.402375857471;10383.325083869524;10430.061294483532;10501.369917804956;10543.89456105429 09:55:08 INFO - PROCESS | 17980 | |3;mootools.html;1465.9780103298447;1530.6249968757656;1535.1863512338462;1802.7295905614155;1957.4812674641214;7992.880106798402;8233.094359620452;8234.46475979061;8234.752957411272;8242.216989386014;8162.795930101751;8340.541270230135;8346.707865224718;8359.080501144868;8366;2114.746230452348;2124.479502521884;2156.385430152399;2436.2082323244927;2465.7657522535333;2378.797802186816;2391.1033362489065;2392.808575313971;2394.4851856850773;2394.545036443079;2355.3640517060385;2449.1917667169882;2449.951000979979;2453.717822450414;2453.754624537541;2386.737458879522;2403.182917807945;2470.5800013997664;2477;2478.876056197192;2429.149797570854;2443.0350011745263;2446.816488763332;2471.0609968212143;2476.839005464639;8432.325413966868;8498.447600905922;8509.702160424355;8511.489310641382;8514.148585141498;5117.513836185556;5197.844064678028;5248;5256.395514515842;5275.86810329741;3305;3324.0858763839897;3380.408428525023;3450.3271861986923;3462.41139006367;1019.7807471393612;1043.57213542448;1051.2063392138962;1051.3796859852723;1054.3568423261804;11841.28952262867;11843.28940263587;11881.643550693492;11891.28652280866;11895.226810257393;4640.814367425332;4646.97676511622;4708.340832283483;4711.929321060187;4753.595944344769;9909.65316213929;9940.552675129637;9956.551955162035;10021.949890250502;10031.197504199647;4658.417697787777;5081.466446023114;5085.415177254589;5093.2105523643895;5093.719845408464;4566.20091483989;4695.835645752382;4707.8587642370785;4757.26262429324;4773.522647735268;3817.770933743984;3925.430812532167;3930.5283365996265;3948.1314110895555;3993.520777506718;1236.5177580743518;1247.607003793802;1253.0476837603487;1257.2770656872335;1277.8594354620984;1062.0759938853093;1074.0226393981438;1083.8428427877914;1275.9489620415266;1409.133382969487;7970.043594768665;8054.073781515201;8062.193780621891;8068.193180682002;8133.511989280662;504.5358270391176;512.106374376715;517.5911030286031;520.1573451009389;520.2508387921457;5922.822315330547;5928.288605367384;5935.139404786281;5943.138244954457;5962.165296858443;9885.357451765756;10437.373757574569;10466.52900619474;10645.254832161674;10656.147508199481;10191.592336306465;10323.896761032294;10446.268761186644;10479.31884427525;10498.10766084876;7799.571023593643;7939.928109705116;8008.83982320362;8019.318357939524;8019.719309824128;7645.961770191336;7663.578503182379;7700.768976930701;7726.381889448943;7780.92219077802;9196.448213107235;9227.35408521397;9256.444613323221;9486.098820612031;9507.096825801538;9381.484018379055;9532.618695252113;9570.282228833004;9703.369280996712;9782.706518804447;6570.5729127606555;6840.657967101724;6964.79105626832;7612;7680.884786728092;7515.549067055994;7536.208698086622;7570.9242907570215;7601.923980760122;7618.276263754934;6663.26704062543;6838.179418469816;6848.383645471931;6927.757528486681;6998.2651821558;6798.694058767268;6838.794836154923;6892.827679307857;6958.443324533924;6958.617276049866;7103.538270012433;7120.643967801486;7122.145342558719;7149.785506434815;7371.262873712586;6679.56582822115;6993.965030174817;7004.719811207495;7030.753923612649;7051.753188638373;6928.722851086101;6982.406495447944;6987.091678081817;7001.36987671112;7049.9647501762165 09:55:08 INFO - PROCESS | 17980 | |4;prototype.html;345.20086000907895;348.28775154808415;356.25009355307077;368.5890232390885;371.09823129794603;6038.728257228424;6078.604890682108;6078.635281883079;6087.9391206087985;6090.665013424265;5937.22816033916;6003.579749417531;6022.277326720789;6031.4270144336215;6050;4352.412424322715;4595.724256544601;4710.057988402316;4727.479977202523;4728.952710472903;4698.31874378215;4714.3164241185;4716.339712440261;4733.431988161426;4735.195016847127;4392.912141757163;4646.651501137411;4670.065986802636;4673.789679464416;4686.625069994392;4471.8434854779925;4499.572540608637;4531.07113041829;4630.513796051399;4670.836520721792;4054.3513037914086;4103.056297051695;4103.7948102594755;4106.835726570934;4107.0553772632165;5703.942960570383;5717.828465146053;5721.885562288772;5721.9427805721825;5723.742431590588;5437.265969094161;5439.564834813205;5451.373092094381;5452.6455780374545;5458.4541545845095;6354.904676429857;6357.713902874336;6371.203599550056;6375.8406039848915;6380.585261957958;4326.5673432656795;4440.777961101964;4450.777461126931;4462.776861156929;4493.5281795411665;6571.244306904671;6684.3984041436015;6690.13028306317;6722.260551339349;6769.492288078413;4532.138893610204;4535.501094879561;4539.251023581138;4541.114482675846;4541.477730061085;4585.931211031837;4604.424446944132;4606.654500912378;4608.101420223024;4609.124266389375;5330.466953304716;5332.866678332995;5338.946610533845;5342.759575819097;5346.064438723208;6277.937220627827;6482.513811464159;6484.351564843478;6492.448141907897;6506.577072490273;1629.1772654809245;1635.362208738593;1647.9917600412161;1648.917554122313;1650.6946214950271;992.4938281476499;1051.1275641217771;1055.2982266792496;1082.9945850270856;1095.638439315024;6300.653464059429;6417.518686098561;6427.357264273535;6431.163948686641;6434.806955791334;6760.425363844129;6782.050512928194;6812;6816.216135144423;6827.078344423439;6342.5243106767175;6349.841253968595;6350.523710721714;6359.777407790798;6363.395477429637;3591.1560783215923;3625.9456108158397;3627.891163265106;3629.764065335745;3630.3102410541915;6715.160604924385;6826.453883689393;6865.794026179223;6884.414824739853;6890;6806.761763338359;6870.896936545956;6883.759068432681;6904.4821638377325;6916.20463646687;6933.341332573397;6951.131108611424;6951.93048069523;6960.33876781715;6961.860762784716;6722.932770672426;6723.663816809238;6727.2263689674355;6734.8653026940165;6738;6502.349765023459;6614.801555953137;6632.1709786276715;6635.535512514078;6642.103316052271;6907.998340240738;6932.757353492603;6937.479689023445;6940.514164008471;6944.062551555678;4567.794449249858;4635.6986795858165;4642.698224615389;4645.419322584677;4648.093621743727;6710.530262881747;6711.664416779239;6715.227748808754;6716.5634233774645;6723.562968407038;6365.299817020032;6552.049952756919;6605.339466053356;6605.735770569124;6610.900836487361;6543.083968244355;6575.408213260829;6578.868422631424;6581.506387020897;6600.60396376219;6420.7431702731365;6468.2561505427475;6472.967635161794;6473.320301368477;6474.579152355271;6591.439727623206;6592.604443733391;6595.769148079794;6603.141591593062;6609.801705948829;5987.191729116687;6136.693165341626;6363.872722545616;6418.486521078209;6438.90341644885 09:55:08 INFO - PROCESS | 17980 | |5;yui.html;681.3969636871367;795.9522428654285;810.359815745561;820.4912953968541;920.1120918313828;14091;14418.783718244234;14437.205953672545;14442.855571444283;14444;12946.287954162517;13817.240051797147;13908.513202037931;13934;13956.860431395682;900.3832374823266;923.3259720404109;924.482289917645;925.2043242811177;926.1155596405416;904.1230006893336;925.3568769705058;930.9487978161198;933.0855761353878;933.9533023348839;797.1510341486328;970.5050424283596;980.5734505490099;983.2134292565954;984.7981163861427;957.1242313283337;961.5336561767572;964.6575465709677;969.2827307792184;969.5879251318162;709.8154479835229;717.1465955512975;717.4045542200014;717.4188906985306;717.7129148340654;13475;13523.053386262965;13543.525976590772;13547.59357219285;13549.932250338783;14104.576862694135;14350.210738409383;14376;14442.566722998326;14454.566363009126;10728.570857165781;10815.242932994694;10854.620088296952;10985.560577576887;10999.175061870312;3927.8232479538487;3960.4455376247347;3973.7615743055508;4004.179143275651;4070.715049946505;48134.518654813706;49567.50432495665;49583.256251156265;49629.00741985176;50878;11073.280236784583;11246.381449020382;11266.605668801552;11620.535178592761;11677.824832627517;19816.50458738514;19892.303769368;19914.103865326095;19922.30271940504;19925.20299188045;8152.6331315090965;8305.792355191048;8371.748847534584;8385.161483851565;8593.656253749905;4535.16099521583;4570.200214962369;4746.833860814855;4759.904801903943;4962.702237865739;3408.0968543336035;3449.99950014498;3460.5501284833313;3470.2712430389397;3471.1322169457635;561.3880869851881;631.6557476175495;652.7030201258416;657.139147716493;673.4376795375916;659.5037781995126;682.5904457325664;717.6626985316892;719.3310221494061;742.550756792133;8331.416800823885;8613.956930215309;8632.870506942401;9240.260779137652;9629.518524073768;598.8353202869158;644.9742010319628;684.4455990647591;708.7909066825299;717.9676914538858;4152.446245558959;4384.298512238027;4402.207602631493;4465.665075119379;4526.864194074183;58760.7061964696;59160.40839591635;59208;59356.10965835516;59919.70040149859;52432.737836310574;52841;53201.7339913298;53349;53787.462125379025;45208.095838083056;45894.31158532625;46267.074658506644;47475.5252447478;48424;8076.596170191585;8215.465994710325;8516.977962644522;8687.131286871263;8866.157715017063;36251.27497450089;36793.816030919676;37399.87800365884;37453.43819842759;37808.810955945046;42057.78971105125;45250;45425.31862022006;46306.76846615745;46523;11283.605073822377;11333.979941805277;11393.715157121138;11561.710957226136;12288.016958643466;11558;11614.361210133524;11710.765784684429;12518.37408129608;12639.87360126387;11331.603393881174;11426.828597570877;11476.540938362707;11509.654710358702;11578.652640420802;11453.541858325574;11489.482973266056;11494.195406321478;11633.243839150766;12035.578754743541;10973.396463194282;11503.079753619857;11541.769164616828;11547.20007127912;11659.417029148679;9742.171915387271;9792.559334829808;9947.353422027545;10004.599816007569;10223;10438.843417348595;10588.205884558844;10689.251752377259;10747.247692661438;10845.13238940867 09:55:08 INFO - PROCESS | 17980 | __end_tp_report 09:55:08 INFO - PROCESS | 17980 | __start_cc_report 09:55:08 INFO - PROCESS | 17980 | _x_x_mozilla_cycle_collect,780 09:55:08 INFO - PROCESS | 17980 | __end_cc_report 09:55:08 INFO - PROCESS | 17980 | __startTimestamp1458838508617__endTimestamp 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | ------- Summary: start ------- 09:55:08 INFO - PROCESS | 17980 | Number of tests: 6 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | [#0] dojo.html Cycles:165 Average:5309.85 Median:5518.34 stddev:575.65 (10.4%) stddev-sans-first:554.12 09:55:08 INFO - PROCESS | 17980 | Values: 3243.6 3281.2 3301.5 3301.9 3334.8 5297.8 5309.3 5323.0 5324.2 5388.9 5320.2 5344.2 5348.4 5378.4 5382.1 4741.8 4825.1 4886.2 4892.1 4933.5 4813.0 4861.1 4888.3 4922.7 4931.2 4889.1 4908.4 4912.8 4916.7 4922.6 4900.4 4913.7 4916.6 4924.4 4943.4 4796.6 4796.9 4837.7 4844.8 4871.7 5091.0 5122.1 5125.1 5125.4 5139.6 5670.4 5674.2 5680.1 5681.5 5704.5 5493.0 5714.3 5755.5 5877.8 5878.2 5308.5 5312.8 5328.1 5331.3 5333.8 5766.6 5767.4 5768.6 5775.5 5781.3 5385.6 5629.9 5695.0 5718.7 5739.5 5756.1 5760.7 5765.6 5766.3 5773.0 5579.9 5751.8 5753.4 5755.1 5756.2 5679.7 5794.8 5799.2 5826.5 5829.2 4356.8 4359.8 4360.0 4361.3 4384.5 3905.4 3912.5 3942.4 3951.1 3965.0 5366.9 5375.8 5385.3 5390.8 5410.5 5673.7 5674.7 5675.7 5687.7 5699.1 5222.1 5301.4 5383.7 5411.2 5419.4 4941.9 4955.4 4960.8 4962.7 4970.6 5863.2 5881.6 5886.2 5888.4 5923.0 5545.3 5730.8 5758.7 5819.0 5849.1 5858.7 5862.0 5862.0 5865.6 5872.4 5621.5 5624.6 5626.1 5627.0 5645.8 5604.2 5791.9 5850.4 5856.4 5882.3 5525.4 5549.6 5550.3 5557.0 5557.0 5518.3 5555.3 5556.0 5559.8 5573.5 5527.2 5588.7 5592.6 5608.7 5636.4 5522.8 5542.9 5544.6 5544.6 5581.2 5431.7 5461.0 5491.2 5495.3 5497.2 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | [#1] ext.html Cycles:180 Average:47170.05 Median:346982.50 stddev:77573.57 (22.4%) stddev-sans-first:77712.13 09:55:08 INFO - PROCESS | 17980 | Values: 528.7 538.9 543.3 560.4 601.7 31189.0 38159.6 38771.4 39005.4 39032.6 43517.8 44185.8 44213.6 44317.1 44319.0 7863.6 9045.4 9242.8 10445.8 10632.9 10608.6 10752.7 10759.9 10770.0 10772.7 10724.9 10804.6 10808.9 10838.3 10839.8 10718.0 10721.9 10758.1 10772.9 10780.2 10901.1 11010.5 11017.3 11074.6 11087.8 43767.6 44375.0 44394.6 44497.6 44509.6 3652.3 3671.2 3695.6 3752.6 4415.7 29568.1 29741.3 29997.0 30119.0 30885.4 3813.9 3896.7 3917.5 3922.7 4225.9 298554.0 299129.0 300836.0 301675.0 301948.0 44560.8 45235.0 45249.1 65565.0 65809.0 43982.8 44141.3 44171.3 44208.8 44222.3 14790.6 15358.8 15704.1 15837.4 15887.4 12453.1 12518.2 12553.6 12554.3 12567.4 15044.2 15241.7 15306.8 15312.0 15467.4 5872.5 5921.3 5993.3 6017.1 6031.6 907.2 1042.8 1070.6 1131.9 1235.2 29646.3 30128.8 30183.8 30780.1 31222.0 1112.9 1143.6 1144.3 1152.4 1163.3 15826.5 15972.8 16136.5 16148.8 16416.9 341891.0 346962.0 347003.0 348304.0 350351.0 57777.7 58211.0 58842.7 58914.4 58929.0 1282.3 1442.4 1457.4 1461.5 1476.2 27712.7 27839.0 27997.6 28546.4 28701.6 42930.8 43579.1 43652.6 43686.1 43699.3 188740.0 227043.0 227235.0 228526.0 282586.0 33669.0 34365.8 34787.5 34897.0 35398.0 40742.6 40897.6 41400.8 41703.4 55798.7 39778.2 40362.1 40584.2 40905.2 44177.1 42625.8 43178.6 43257.1 43438.0 43550.1 42627.4 43338.0 43626.8 44228.0 44234.0 37854.2 38277.8 39348.0 39354.8 40423.2 30074.8 30151.0 30443.5 30445.4 30540.4 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | [#2] jquery.html Cycles:180 Average:26383.81 Median:18396.03 stddev:74457.30 (404.7%) stddev-sans-first:74640.58 09:55:08 INFO - PROCESS | 17980 | Values: 386.9 394.2 395.3 399.7 400.4 14100.2 14274.6 18627.5 19348.5 19362.2 17980.4 18063.2 18173.7 18261.6 18281.0 5521.7 5710.0 5719.2 5723.8 5730.8 4163.9 5590.1 5978.6 6226.5 6242.4 6151.8 6188.8 6218.3 6218.8 6221.4 6154.7 6163.2 6165.0 6165.0 6165.0 5481.3 5506.0 5506.9 5509.4 5511.4 21325.6 21902.9 22083.8 22118.7 22192.8 2285.0 2372.4 2377.8 2411.1 2462.4 13315.4 13735.3 13952.4 14138.2 14187.4 1937.2 2010.3 2025.4 2028.6 2084.0 60023.1 62257.4 62384.7 62626.0 64278.4 10431.9 10876.7 11128.9 11139.2 11221.1 14732.3 14834.6 14850.4 14856.4 14859.1 7380.1 7394.0 7461.1 7461.6 7493.3 7165.3 7393.4 7683.6 7741.5 7757.0 4919.3 4982.6 4993.7 5009.5 5048.6 1949.5 1979.1 1982.1 2002.2 2002.6 797.8 906.1 967.7 986.4 1027.9 16650.3 16828.9 17950.0 18262.4 18279.6 950.4 989.4 990.8 1029.9 1051.1 8724.6 10339.8 10375.8 10416.5 10576.2 435149.0 443529.0 459568.0 465365.0 466164.0 76576.0 79653.6 80293.0 80910.6 82357.2 1054.9 1073.9 1093.4 1102.3 1106.0 16038.3 16058.9 16065.9 16227.1 16492.9 34329.7 34377.7 34856.7 35340.5 35385.3 46957.8 50101.5 50146.7 50360.2 50448.7 7891.9 7927.3 7978.7 7982.4 8115.3 11258.3 11525.3 11549.4 11728.9 11961.9 10167.7 10375.2 10381.7 10455.1 10533.0 10136.7 10159.6 10308.6 10434.9 10461.2 10423.1 10601.0 10631.8 10788.1 11011.6 7988.5 8023.7 8041.5 8187.8 8321.4 9960.4 10383.3 10430.1 10501.4 10543.9 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | [#3] mootools.html Cycles:180 Average:5842.94 Median:2859.00 stddev:3121.99 (109.2%) stddev-sans-first:3113.41 09:55:08 INFO - PROCESS | 17980 | Values: 1466.0 1530.6 1535.2 1802.7 1957.5 7992.9 8233.1 8234.5 8234.8 8242.2 8162.8 8340.5 8346.7 8359.1 8366.0 2114.7 2124.5 2156.4 2436.2 2465.8 2378.8 2391.1 2392.8 2394.5 2394.5 2355.4 2449.2 2450.0 2453.7 2453.8 2386.7 2403.2 2470.6 2477.0 2478.9 2429.1 2443.0 2446.8 2471.1 2476.8 8432.3 8498.4 8509.7 8511.5 8514.1 5117.5 5197.8 5248.0 5256.4 5275.9 3305.0 3324.1 3380.4 3450.3 3462.4 1019.8 1043.6 1051.2 1051.4 1054.4 11841.3 11843.3 11881.6 11891.3 11895.2 4640.8 4647.0 4708.3 4711.9 4753.6 9909.7 9940.6 9956.6 10021.9 10031.2 4658.4 5081.5 5085.4 5093.2 5093.7 4566.2 4695.8 4707.9 4757.3 4773.5 3817.8 3925.4 3930.5 3948.1 3993.5 1236.5 1247.6 1253.0 1257.3 1277.9 1062.1 1074.0 1083.8 1275.9 1409.1 7970.0 8054.1 8062.2 8068.2 8133.5 504.5 512.1 517.6 520.2 520.3 5922.8 5928.3 5935.1 5943.1 5962.2 9885.4 10437.4 10466.5 10645.3 10656.1 10191.6 10323.9 10446.3 10479.3 10498.1 7799.6 7939.9 8008.8 8019.3 8019.7 7646.0 7663.6 7700.8 7726.4 7780.9 9196.4 9227.4 9256.4 9486.1 9507.1 9381.5 9532.6 9570.3 9703.4 9782.7 6570.6 6840.7 6964.8 7612.0 7680.9 7515.5 7536.2 7570.9 7601.9 7618.3 6663.3 6838.2 6848.4 6927.8 6998.3 6798.7 6838.8 6892.8 6958.4 6958.6 7103.5 7120.6 7122.1 7149.8 7371.3 6679.6 6994.0 7004.7 7030.8 7051.8 6928.7 6982.4 6987.1 7001.4 7050.0 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | [#4] prototype.html Cycles:180 Average:5423.35 Median:6207.32 stddev:1647.27 (26.5%) stddev-sans-first:1607.19 09:55:08 INFO - PROCESS | 17980 | Values: 345.2 348.3 356.3 368.6 371.1 6038.7 6078.6 6078.6 6087.9 6090.7 5937.2 6003.6 6022.3 6031.4 6050.0 4352.4 4595.7 4710.1 4727.5 4729.0 4698.3 4714.3 4716.3 4733.4 4735.2 4392.9 4646.7 4670.1 4673.8 4686.6 4471.8 4499.6 4531.1 4630.5 4670.8 4054.4 4103.1 4103.8 4106.8 4107.1 5703.9 5717.8 5721.9 5721.9 5723.7 5437.3 5439.6 5451.4 5452.6 5458.5 6354.9 6357.7 6371.2 6375.8 6380.6 4326.6 4440.8 4450.8 4462.8 4493.5 6571.2 6684.4 6690.1 6722.3 6769.5 4532.1 4535.5 4539.3 4541.1 4541.5 4585.9 4604.4 4606.7 4608.1 4609.1 5330.5 5332.9 5338.9 5342.8 5346.1 6277.9 6482.5 6484.4 6492.4 6506.6 1629.2 1635.4 1648.0 1648.9 1650.7 992.5 1051.1 1055.3 1083.0 1095.6 6300.7 6417.5 6427.4 6431.2 6434.8 6760.4 6782.1 6812.0 6816.2 6827.1 6342.5 6349.8 6350.5 6359.8 6363.4 3591.2 3625.9 3627.9 3629.8 3630.3 6715.2 6826.5 6865.8 6884.4 6890.0 6806.8 6870.9 6883.8 6904.5 6916.2 6933.3 6951.1 6951.9 6960.3 6961.9 6722.9 6723.7 6727.2 6734.9 6738.0 6502.3 6614.8 6632.2 6635.5 6642.1 6908.0 6932.8 6937.5 6940.5 6944.1 4567.8 4635.7 4642.7 4645.4 4648.1 6710.5 6711.7 6715.2 6716.6 6723.6 6365.3 6552.0 6605.3 6605.7 6610.9 6543.1 6575.4 6578.9 6581.5 6600.6 6420.7 6468.3 6473.0 6473.3 6474.6 6591.4 6592.6 6595.8 6603.1 6609.8 5987.2 6136.7 6363.9 6418.5 6438.9 09:55:08 INFO - PROCESS | 17980 | 09:55:08 INFO - PROCESS | 17980 | [#5] yui.html Cycles:180 Average:14367.63 Median:24980.24 stddev:16349.36 (65.4%) stddev-sans-first:16362.92 09:55:08 INFO - PROCESS | 17980 | Values: 681.4 796.0 810.4 820.5 920.1 14091.0 14418.8 14437.2 14442.9 14444.0 12946.3 13817.2 13908.5 13934.0 13956.9 900.4 923.3 924.5 925.2 926.1 904.1 925.4 930.9 933.1 934.0 797.2 970.5 980.6 983.2 984.8 957.1 961.5 964.7 969.3 969.6 709.8 717.1 717.4 717.4 717.7 13475.0 13523.1 13543.5 13547.6 13549.9 14104.6 14350.2 14376.0 14442.6 14454.6 10728.6 10815.2 10854.6 10985.6 10999.2 3927.8 3960.4 3973.8 4004.2 4070.7 48134.5 49567.5 49583.3 49629.0 50878.0 11073.3 11246.4 11266.6 11620.5 11677.8 19816.5 19892.3 19914.1 19922.3 19925.2 8152.6 8305.8 8371.7 8385.2 8593.7 4535.2 4570.2 4746.8 4759.9 4962.7 3408.1 3450.0 3460.6 3470.3 3471.1 561.4 631.7 652.7 657.1 673.4 659.5 682.6 717.7 719.3 742.6 8331.4 8614.0 8632.9 9240.3 9629.5 598.8 645.0 684.4 708.8 718.0 4152.4 4384.3 4402.2 4465.7 4526.9 58760.7 59160.4 59208.0 59356.1 59919.7 52432.7 52841.0 53201.7 53349.0 53787.5 45208.1 45894.3 46267.1 47475.5 48424.0 8076.6 8215.5 8517.0 8687.1 8866.2 36251.3 36793.8 37399.9 37453.4 37808.8 42057.8 45250.0 45425.3 46306.8 46523.0 11283.6 11334.0 11393.7 11561.7 12288.0 11558.0 11614.4 11710.8 12518.4 12639.9 11331.6 11426.8 11476.5 11509.7 11578.7 11453.5 11489.5 11494.2 11633.2 12035.6 10973.4 11503.1 11541.8 11547.2 11659.4 9742.2 9792.6 9947.4 10004.6 10223.0 10438.8 10588.2 10689.3 10747.2 10845.1 09:55:08 INFO - PROCESS | 17980 | -------- Summary: end -------- 09:55:08 INFO - PROCESS | 17980 | 09:55:09 INFO - TEST-INFO | 17980: exit 0 09:55:09 INFO - TEST-OK | dromaeo_css | took 1112717ms 09:55:09 INFO - TEST-START | kraken 09:55:09 INFO - operating with platform_type : linux_ 09:55:09 INFO - Initialising browser for kraken test... 09:55:09 INFO - TEST-INFO | started process 18169 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcqc6Tz/profile http://localhost:59420/getInfo.html) 09:55:13 INFO - PROCESS | 18169 | __metrics Screen width/height:1600/1200 09:55:13 INFO - PROCESS | 18169 | colorDepth:24 09:55:13 INFO - PROCESS | 18169 | Browser inner width/height: 1024/697 09:55:13 INFO - PROCESS | 18169 | __metrics 09:55:14 INFO - PROCESS | 18169 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:55:15 INFO - TEST-INFO | 18169: exit 0 09:55:15 INFO - Browser initialized. 09:55:15 INFO - Running cycle 1/1 for kraken test... 09:55:15 INFO - TEST-INFO | started process 18261 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcqc6Tz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:27 INFO - PROCESS | 18261 | RSS: Main: 144429056 09:55:27 INFO - PROCESS | 18261 | 09:55:29 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59420/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:30 INFO - PROCESS | 18261 | RSS: Main: 180146176 09:55:30 INFO - PROCESS | 18261 | 09:55:33 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59420/tests/kraken/driver.html?testName=audio-dft) 09:55:33 INFO - PROCESS | 18261 | RSS: Main: 177446912 09:55:33 INFO - PROCESS | 18261 | 09:55:36 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59420/tests/kraken/driver.html?testName=audio-fft) 09:55:37 INFO - PROCESS | 18261 | RSS: Main: 175771648 09:55:37 INFO - PROCESS | 18261 | 09:55:39 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59420/tests/kraken/driver.html?testName=audio-oscillator) 09:55:39 INFO - PROCESS | 18261 | RSS: Main: 174563328 09:55:39 INFO - PROCESS | 18261 | 09:55:41 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:42 INFO - PROCESS | 18261 | RSS: Main: 172826624 09:55:42 INFO - PROCESS | 18261 | 09:55:45 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59420/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:46 INFO - PROCESS | 18261 | RSS: Main: 173051904 09:55:46 INFO - PROCESS | 18261 | 09:55:49 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59420/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:50 INFO - PROCESS | 18261 | RSS: Main: 174096384 09:55:50 INFO - PROCESS | 18261 | 09:55:52 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59420/tests/kraken/driver.html?testName=json-parse-financial) 09:55:53 INFO - PROCESS | 18261 | RSS: Main: 174485504 09:55:53 INFO - PROCESS | 18261 | 09:55:54 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:55 INFO - PROCESS | 18261 | RSS: Main: 178831360 09:55:55 INFO - PROCESS | 18261 | 09:55:57 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:57 INFO - PROCESS | 18261 | RSS: Main: 176390144 09:55:57 INFO - PROCESS | 18261 | 09:55:59 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:00 INFO - PROCESS | 18261 | RSS: Main: 182530048 09:56:00 INFO - PROCESS | 18261 | 09:56:02 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:03 INFO - PROCESS | 18261 | RSS: Main: 189964288 09:56:03 INFO - PROCESS | 18261 | 09:56:05 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:06 INFO - PROCESS | 18261 | RSS: Main: 187838464 09:56:06 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:59420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59420/tests/kraken/driver.html?testName=ai-astar) 09:56:08 INFO - PROCESS | 18261 | RSS: Main: 249749504 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | __start_tp_report 09:56:08 INFO - PROCESS | 18261 | _x_x_mozilla_page_load 09:56:08 INFO - PROCESS | 18261 | _x_x_mozilla_page_load_details 09:56:08 INFO - PROCESS | 18261 | |i|pagename|runs| 09:56:08 INFO - PROCESS | 18261 | |0;ai-astar;111;110;104;110;111;110;98;110;109;108 09:56:08 INFO - PROCESS | 18261 | |1;audio-beat-detection;152;132;154;171;127;154;165;133;163;126 09:56:08 INFO - PROCESS | 18261 | |2;audio-dft;162;161;161;162;164;160;161;166;162;161 09:56:08 INFO - PROCESS | 18261 | |3;audio-fft;72;76;74;161;76;77;78;74;160;76 09:56:08 INFO - PROCESS | 18261 | |4;audio-oscillator;93;93;149;93;94;93;149;91;93;141 09:56:08 INFO - PROCESS | 18261 | |5;imaging-gaussian-blur;117;116;117;116;116;117;116;116;116;117 09:56:08 INFO - PROCESS | 18261 | |6;imaging-darkroom;145;146;145;145;145;146;146;145;145;145 09:56:08 INFO - PROCESS | 18261 | |7;imaging-desaturate;96;95;96;95;96;96;95;95;95;95 09:56:08 INFO - PROCESS | 18261 | |8;json-parse-financial;54;57;54;55;55;55;56;64;53;53 09:56:08 INFO - PROCESS | 18261 | |9;json-stringify-tinderbox;65;66;67;66;67;66;66;66;65;67 09:56:08 INFO - PROCESS | 18261 | |10;stanford-crypto-aes;85;78;79;79;78;79;79;78;85;79 09:56:08 INFO - PROCESS | 18261 | |11;stanford-crypto-ccm;109;119;111;115;112;123;121;115;111;117 09:56:08 INFO - PROCESS | 18261 | |12;stanford-crypto-pbkdf2;147;136;152;143;147;134;135;145;157;148 09:56:08 INFO - PROCESS | 18261 | |13;stanford-crypto-sha256-iterative;66;66;68;71;71;67;68;68;73;67 09:56:08 INFO - PROCESS | 18261 | __end_tp_report 09:56:08 INFO - PROCESS | 18261 | __start_cc_report 09:56:08 INFO - PROCESS | 18261 | _x_x_mozilla_cycle_collect,1072 09:56:08 INFO - PROCESS | 18261 | __end_cc_report 09:56:08 INFO - PROCESS | 18261 | __startTimestamp1458838568466__endTimestamp 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | ------- Summary: start ------- 09:56:08 INFO - PROCESS | 18261 | Number of tests: 14 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.09 (3.7%) stddev-sans-first:4.21 09:56:08 INFO - PROCESS | 18261 | Values: 111.0 110.0 104.0 110.0 111.0 110.0 98.0 110.0 109.0 108.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:154.00 stddev:16.79 (10.9%) stddev-sans-first:17.73 09:56:08 INFO - PROCESS | 18261 | Values: 152.0 132.0 154.0 171.0 127.0 154.0 165.0 133.0 163.0 126.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.76 (1.1%) stddev-sans-first:1.87 09:56:08 INFO - PROCESS | 18261 | Values: 162.0 161.0 161.0 162.0 164.0 160.0 161.0 166.0 162.0 161.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:35.93 (47.3%) stddev-sans-first:37.35 09:56:08 INFO - PROCESS | 18261 | Values: 72.0 76.0 74.0 161.0 76.0 77.0 78.0 74.0 160.0 76.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:25.93 (27.9%) stddev-sans-first:26.86 09:56:08 INFO - PROCESS | 18261 | Values: 93.0 93.0 149.0 93.0 94.0 93.0 149.0 91.0 93.0 141.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:56:08 INFO - PROCESS | 18261 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:56:08 INFO - PROCESS | 18261 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:56:08 INFO - PROCESS | 18261 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.20 (5.8%) stddev-sans-first:3.35 09:56:08 INFO - PROCESS | 18261 | Values: 54.0 57.0 54.0 55.0 55.0 55.0 56.0 64.0 53.0 53.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 09:56:08 INFO - PROCESS | 18261 | Values: 65.0 66.0 67.0 66.0 67.0 66.0 66.0 66.0 65.0 67.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.73 (3.5%) stddev-sans-first:2.18 09:56:08 INFO - PROCESS | 18261 | Values: 85.0 78.0 79.0 79.0 78.0 79.0 79.0 78.0 85.0 79.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:116.00 stddev:4.67 (4.0%) stddev-sans-first:4.36 09:56:08 INFO - PROCESS | 18261 | Values: 109.0 119.0 111.0 115.0 112.0 123.0 121.0 115.0 111.0 117.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:147.00 stddev:7.55 (5.1%) stddev-sans-first:7.94 09:56:08 INFO - PROCESS | 18261 | Values: 147.0 136.0 152.0 143.0 147.0 134.0 135.0 145.0 157.0 148.0 09:56:08 INFO - PROCESS | 18261 | 09:56:08 INFO - PROCESS | 18261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:2.37 (3.5%) stddev-sans-first:2.33 09:56:08 INFO - PROCESS | 18261 | Values: 66.0 66.0 68.0 71.0 71.0 67.0 68.0 68.0 73.0 67.0 09:56:08 INFO - PROCESS | 18261 | -------- Summary: end -------- 09:56:08 INFO - PROCESS | 18261 | 09:56:09 INFO - TEST-INFO | 18261: exit 0 09:56:09 INFO - TEST-OK | kraken | took 60092ms 09:56:09 INFO - SUITE-END | took 1172s 09:56:09 INFO - Completed test suite (00:19:33) 09:56:09 INFO - javascript benchmark 09:56:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3243.56211911392, 3281.1633033576436, 3301.537784710141, 3301.900942971709, 3334.799912005279, 5297.814576489824, 5309.30978972734, 5323.0152421801995, 5324.227986941901, 5388.91916621251, 5320.17537281721, 5344.171653393721, 5348.384935732392, 5378.354597448311, 5382.058139825534, 4741.81032758691, 4825.083234185511, 4886.218205087187, 4892.0705066037335, 4933.531314525115, 4813.0, 4861.076395484846, 4888.266759985995, 4922.68002579833, 4931.161702510564, 4889.095517329305, 4908.43552991407, 4912.778924948386, 4916.680415772981, 4922.581580565657, 4900.411950565919, 4913.70781576343, 4916.58209052231, 4924.359833221694, 4943.357363542752, 4796.592289655384, 4796.904061918777, 4837.7097374157665, 4844.806207751686, 4871.732054736988, 5091.032703786269, 5122.129238029506, 5125.128728116192, 5125.38495380553, 5139.58883289336, 5670.404607516234, 5674.169935293701, 5680.091185410314, 5681.488666020078, 5704.4865962063195, 5493.0, 5714.314282286111, 5755.482006619424, 5877.79427720032, 5878.177055212273, 5308.495692909168, 5312.76092575835, 5328.067588172094, 5331.306930099062, 5333.839984800462, 5766.567507436959, 5767.36558978512, 5768.567357448208, 5775.48020678141, 5781.335146458127, 5385.6230063895155, 5629.8592535186945, 5695.03184458643, 5718.7426565804635, 5739.512141467939, 5756.079027355687, 5760.74076666551, 5765.567582431335, 5766.279215098113, 5773.018586840247, 5579.944200558024, 5751.827445176651, 5753.3958934311295, 5755.1367294906095, 5756.222909907193, 5679.6876171810945, 5794.82615521535, 5799.159121927297, 5826.533877289807, 5829.242198514251, 4356.847510337123, 4359.825606975749, 4360.040791025969, 4361.258586040381, 4384.539623339567, 3905.3946638271113, 3912.5304963404005, 3942.42834788954, 3951.1110000249714, 3964.960350396459, 5366.91949620756, 5375.838724838261, 5385.299911011622, 5390.784368625211, 5410.458954104558, 5673.687947162863, 5674.744636491368, 5675.744591493392, 5687.715614219355, 5699.116636921284, 5222.060029194706, 5301.390340110936, 5383.650062745909, 5411.161270003156, 5419.403865574784, 4941.876453088702, 4955.380577427822, 4960.751962401865, 4962.727050012212, 4970.577500912391, 5863.208466857005, 5881.617694849907, 5886.23478947734, 5888.411158884077, 5923.022701254331, 5545.279113715353, 5730.8280751576685, 5758.712064396847, 5819.039858423313, 5849.122631605123, 5858.7070646466655, 5862.0, 5862.032764593965, 5865.648061116347, 5872.412758724094, 5621.494065534122, 5624.578156638187, 5626.127950167731, 5626.971865140648, 5645.802396916252, 5604.187392828098, 5791.942080579141, 5850.3857095006115, 5856.4143585641095, 5882.294124705063, 5525.392206857162, 5549.5837812165055, 5550.250716153268, 5557.0, 5557.027520184032, 5518.3377994639295, 5555.333359996826, 5555.972220138873, 5559.833205003694, 5573.470520300565, 5527.226188333717, 5588.720563971704, 5592.608517403743, 5608.691521966168, 5636.408177141505, 5522.806701765419, 5542.889142217214, 5544.611877168721, 5544.63959842609, 5581.162825576033, 5431.6740995540395, 5461.0, 5491.203775452457, 5495.313085864267, 5497.230387745639], "unit": "score", "name": "dojo.html", "value": 5273.802337284899}, {"lowerIsBetter": false, "replicates": [528.656373357318, 538.8545092824937, 543.3045701502078, 560.3919747074423, 601.6781022153149, 31188.99999999997, 38159.618403815955, 38771.41842872352, 39005.41491877617, 39032.60967390325, 43517.78241108798, 44185.7790711046, 44213.557864421346, 44317.113657726826, 44319.0, 7863.646135923868, 9045.3668243223, 9242.768930776718, 10445.84331235032, 10632.946835265813, 10608.628697995571, 10752.73118172048, 10759.946200268987, 10770.0, 10772.73068173294, 10724.946375268151, 10804.5678172873, 10808.945955270212, 10838.295510791773, 10839.783204335949, 10718.0, 10721.874203208668, 10758.085562727178, 10772.946135269274, 10780.245382823205, 10901.1279097672, 11010.50452729629, 11017.338959662366, 11074.612388566362, 11087.83368249477, 43767.56232437667, 44375.0, 44394.55605443969, 44497.55502444966, 44509.554904451186, 3652.2695460907926, 3671.1556342041213, 3695.575008873987, 3752.6434988676033, 4415.712978656409, 29568.112956611338, 29741.256468588243, 29996.95010674616, 30119.0, 30885.38229235403, 3813.866514671973, 3896.6687831534355, 3917.4907262056036, 3922.7254092213557, 4225.894352641178, 298554.0, 299128.99999999785, 300836.0, 301675.0, 301948.0, 44560.77719611381, 45235.0, 45249.095018099455, 65565.0, 65809.0, 43982.78008609937, 44141.33787993182, 44171.337429938576, 44208.778956105016, 44222.33666495005, 14790.556283311518, 15358.769618455732, 15704.057756534645, 15837.445689400816, 15887.364505419884, 12453.06602004835, 12518.248905065726, 12553.623391298275, 12554.309512976874, 12567.434465449076, 15044.247787610575, 15241.704455121217, 15306.770398444032, 15312.0, 15467.381304747683, 5872.530197584183, 5921.348651648315, 5993.280806303184, 6017.06735456005, 6031.638101713911, 907.2424525521131, 1042.8070806900748, 1070.6199299248653, 1131.8698349689726, 1235.184778046485, 29646.258843529085, 30128.849355753082, 30183.849080754455, 30780.076597702104, 31222.0, 1112.8831472695251, 1143.5997400909782, 1144.3362849547243, 1152.3777160333327, 1163.2613290560555, 15826.525204243891, 15972.76040859388, 16136.515904522883, 16148.83851161497, 16416.917915410348, 341891.0, 346962.0, 347003.0, 348304.0, 350351.0, 57777.71111144417, 58211.0, 58842.7057864708, 58914.41085589089, 58929.0, 1282.2819221236139, 1442.35094207607, 1457.3806132393902, 1461.5030889497623, 1476.1733429279639, 27712.72287277182, 27839.0, 27997.580036299878, 28546.429071418872, 28701.569476458288, 42930.78534607307, 43579.12841743084, 43652.56347436612, 43686.126277474905, 43699.34450983301, 188740.0, 227043.0, 227235.0, 228526.0, 282586.0, 33669.0, 34365.828170858986, 34787.478187826695, 34897.0, 35398.0, 40742.59257407388, 40897.591024090565, 41400.79299603483, 41703.374449382674, 55798.721006394706, 39778.20443591054, 40362.12073678937, 40584.188316234104, 40905.18189636131, 44177.11645767131, 42625.786871065444, 43178.568214317456, 43257.13485730205, 43438.0, 43550.12899741924, 42627.360589590564, 43338.0, 43626.78186609047, 44228.0, 44234.0, 37854.242915142095, 38277.80861095677, 39348.0, 39354.803225983684, 40423.1915361697, 30074.849625751733, 30151.0, 30443.543346849372, 30445.39109217759, 30540.389192215585], "unit": "score", "name": "ext.html", "value": 19346.41975168892}, {"lowerIsBetter": false, "replicates": [386.9090763670537, 394.1860058978208, 395.31412998447706, 399.7201958628959, 400.42938812192625, 14100.224487653175, 14274.64313392163, 18627.534311642215, 19348.51628709283, 19362.225510979562, 17980.370687025956, 18063.18715657795, 18173.7273940891, 18261.63476730468, 18281.0, 5521.668699878, 5709.971450142743, 5719.227904232937, 5723.771049158028, 5730.799422020209, 4163.937540936889, 5590.133529302944, 5978.641281523101, 6226.501879849624, 6242.406971337716, 6151.815445536641, 6188.84527886802, 6218.253809542839, 6218.813435596917, 6221.377862213788, 6154.661493617849, 6163.229596300463, 6164.969175154118, 6165.0, 6165.044418115177, 5481.314835645544, 5506.0, 5506.889862202734, 5509.421510741395, 5511.4213007634025, 21325.5734885303, 21902.89048554763, 22083.77916220833, 22118.668219976713, 22192.778072219233, 2284.954300913989, 2372.3594629450126, 2377.7859992600747, 2411.144043864438, 2462.4090218347646, 13315.40080696371, 13735.313234338244, 13952.372143253579, 14138.164578394795, 14187.361568729431, 1937.225109956029, 2010.3164923925935, 2025.4126303372004, 2028.5739994601151, 2083.9895800521053, 60023.09965350523, 62257.37742622561, 62384.68807655932, 62626.0, 64278.35721642771, 10431.947840260902, 10876.72808179786, 11128.888711112948, 11139.164562657834, 11221.102311815035, 14732.263386830615, 14834.629134271514, 14850.405983760744, 14856.405743770345, 14859.108453492825, 7380.077490313711, 7394.0, 7461.1419686735635, 7461.552306861606, 7493.250674932572, 7165.283471652793, 7393.445491588152, 7683.577403242875, 7741.496802707806, 7757.0, 4919.262110683426, 4982.626303027288, 4993.725345106054, 5009.549140577293, 5048.596112311006, 1949.483386902472, 1979.0797279264923, 1982.0684278389133, 2002.2191345375315, 2002.589469158819, 797.7845981585056, 906.0984320601044, 967.690339091484, 986.413084214891, 1027.9383237005654, 16650.333986640642, 16828.915855420644, 17950.0, 18262.36081737133, 18279.63440731178, 950.4202436513721, 989.3569180033036, 990.8117457683018, 1029.912457441126, 1051.0960573906434, 8724.563771811385, 10339.793204136025, 10375.792484150275, 10416.531256093494, 10576.15390768752, 435149.0, 443529.0, 459568.0, 465365.0, 466164.0, 76576.0, 79653.60173199212, 80293.0, 80910.59544702356, 82357.17642823615, 1054.9156067514734, 1073.9355638661705, 1093.420487141832, 1102.3330884814573, 1105.9557617695364, 16038.278277477308, 16058.919705401866, 16065.919670401574, 16227.107509087113, 16492.917535412726, 34329.65670343264, 34377.65622343744, 34856.65143348635, 35340.469892951114, 35385.292294153456, 46957.765211173726, 50101.49898501114, 50146.7492662549, 50360.244596330354, 50448.747756260986, 7891.921080789119, 7927.326177274997, 7978.680852765824, 7982.361411087215, 8115.310198633182, 11258.268212566158, 11525.250858694159, 11549.36478493691, 11728.94135529317, 11961.940190298992, 10167.694969150938, 10375.16998640122, 10381.688549343531, 10455.059044686015, 10533.0, 10136.695899123039, 10159.593616255266, 10308.639197628047, 10434.947825261128, 10461.215408844215, 10423.11403530678, 10601.0, 10631.787364252517, 10788.083012943987, 11011.559537618405, 7988.520688758693, 8023.719169829028, 8041.517508949481, 8187.754367368989, 8321.375896807642, 9960.402375857471, 10383.325083869524, 10430.061294483532, 10501.369917804956, 10543.89456105429], "unit": "score", "name": "jquery.html", "value": 8827.071969892659}, {"lowerIsBetter": false, "replicates": [1465.9780103298447, 1530.6249968757656, 1535.1863512338462, 1802.7295905614155, 1957.4812674641214, 7992.880106798402, 8233.094359620452, 8234.46475979061, 8234.752957411272, 8242.216989386014, 8162.795930101751, 8340.541270230135, 8346.707865224718, 8359.080501144868, 8366.0, 2114.746230452348, 2124.479502521884, 2156.385430152399, 2436.2082323244927, 2465.7657522535333, 2378.797802186816, 2391.1033362489065, 2392.808575313971, 2394.4851856850773, 2394.545036443079, 2355.3640517060385, 2449.1917667169882, 2449.951000979979, 2453.717822450414, 2453.754624537541, 2386.737458879522, 2403.182917807945, 2470.5800013997664, 2477.0, 2478.876056197192, 2429.149797570854, 2443.0350011745263, 2446.816488763332, 2471.0609968212143, 2476.839005464639, 8432.325413966868, 8498.447600905922, 8509.702160424355, 8511.489310641382, 8514.148585141498, 5117.513836185556, 5197.844064678028, 5248.0, 5256.395514515842, 5275.86810329741, 3305.0, 3324.0858763839897, 3380.408428525023, 3450.3271861986923, 3462.41139006367, 1019.7807471393612, 1043.57213542448, 1051.2063392138962, 1051.3796859852723, 1054.3568423261804, 11841.28952262867, 11843.28940263587, 11881.643550693492, 11891.28652280866, 11895.226810257393, 4640.814367425332, 4646.97676511622, 4708.340832283483, 4711.929321060187, 4753.595944344769, 9909.65316213929, 9940.552675129637, 9956.551955162035, 10021.949890250502, 10031.197504199647, 4658.417697787777, 5081.466446023114, 5085.415177254589, 5093.2105523643895, 5093.719845408464, 4566.20091483989, 4695.835645752382, 4707.8587642370785, 4757.26262429324, 4773.522647735268, 3817.770933743984, 3925.430812532167, 3930.5283365996265, 3948.1314110895555, 3993.520777506718, 1236.5177580743518, 1247.607003793802, 1253.0476837603487, 1257.2770656872335, 1277.8594354620984, 1062.0759938853093, 1074.0226393981438, 1083.8428427877914, 1275.9489620415266, 1409.133382969487, 7970.043594768665, 8054.073781515201, 8062.193780621891, 8068.193180682002, 8133.511989280662, 504.5358270391176, 512.106374376715, 517.5911030286031, 520.1573451009389, 520.2508387921457, 5922.822315330547, 5928.288605367384, 5935.139404786281, 5943.138244954457, 5962.165296858443, 9885.357451765756, 10437.373757574569, 10466.52900619474, 10645.254832161674, 10656.147508199481, 10191.592336306465, 10323.896761032294, 10446.268761186644, 10479.31884427525, 10498.10766084876, 7799.571023593643, 7939.928109705116, 8008.83982320362, 8019.318357939524, 8019.719309824128, 7645.961770191336, 7663.578503182379, 7700.768976930701, 7726.381889448943, 7780.92219077802, 9196.448213107235, 9227.35408521397, 9256.444613323221, 9486.098820612031, 9507.096825801538, 9381.484018379055, 9532.618695252113, 9570.282228833004, 9703.369280996712, 9782.706518804447, 6570.5729127606555, 6840.657967101724, 6964.79105626832, 7612.0, 7680.884786728092, 7515.549067055994, 7536.208698086622, 7570.9242907570215, 7601.923980760122, 7618.276263754934, 6663.26704062543, 6838.179418469816, 6848.383645471931, 6927.757528486681, 6998.2651821558, 6798.694058767268, 6838.794836154923, 6892.827679307857, 6958.443324533924, 6958.617276049866, 7103.538270012433, 7120.643967801486, 7122.145342558719, 7149.785506434815, 7371.262873712586, 6679.56582822115, 6993.965030174817, 7004.719811207495, 7030.753923612649, 7051.753188638373, 6928.722851086101, 6982.406495447944, 6987.091678081817, 7001.36987671112, 7049.9647501762165], "unit": "score", "name": "mootools.html", "value": 4683.32003161817}, {"lowerIsBetter": false, "replicates": [345.20086000907895, 348.28775154808415, 356.25009355307077, 368.5890232390885, 371.09823129794603, 6038.728257228424, 6078.604890682108, 6078.635281883079, 6087.9391206087985, 6090.665013424265, 5937.22816033916, 6003.579749417531, 6022.277326720789, 6031.4270144336215, 6050.0, 4352.412424322715, 4595.724256544601, 4710.057988402316, 4727.479977202523, 4728.952710472903, 4698.31874378215, 4714.3164241185, 4716.339712440261, 4733.431988161426, 4735.195016847127, 4392.912141757163, 4646.651501137411, 4670.065986802636, 4673.789679464416, 4686.625069994392, 4471.8434854779925, 4499.572540608637, 4531.07113041829, 4630.513796051399, 4670.836520721792, 4054.3513037914086, 4103.056297051695, 4103.7948102594755, 4106.835726570934, 4107.0553772632165, 5703.942960570383, 5717.828465146053, 5721.885562288772, 5721.9427805721825, 5723.742431590588, 5437.265969094161, 5439.564834813205, 5451.373092094381, 5452.6455780374545, 5458.4541545845095, 6354.904676429857, 6357.713902874336, 6371.203599550056, 6375.8406039848915, 6380.585261957958, 4326.5673432656795, 4440.777961101964, 4450.777461126931, 4462.776861156929, 4493.5281795411665, 6571.244306904671, 6684.3984041436015, 6690.13028306317, 6722.260551339349, 6769.492288078413, 4532.138893610204, 4535.501094879561, 4539.251023581138, 4541.114482675846, 4541.477730061085, 4585.931211031837, 4604.424446944132, 4606.654500912378, 4608.101420223024, 4609.124266389375, 5330.466953304716, 5332.866678332995, 5338.946610533845, 5342.759575819097, 5346.064438723208, 6277.937220627827, 6482.513811464159, 6484.351564843478, 6492.448141907897, 6506.577072490273, 1629.1772654809245, 1635.362208738593, 1647.9917600412161, 1648.917554122313, 1650.6946214950271, 992.4938281476499, 1051.1275641217771, 1055.2982266792496, 1082.9945850270856, 1095.638439315024, 6300.653464059429, 6417.518686098561, 6427.357264273535, 6431.163948686641, 6434.806955791334, 6760.425363844129, 6782.050512928194, 6812.0, 6816.216135144423, 6827.078344423439, 6342.5243106767175, 6349.841253968595, 6350.523710721714, 6359.777407790798, 6363.395477429637, 3591.1560783215923, 3625.9456108158397, 3627.891163265106, 3629.764065335745, 3630.3102410541915, 6715.160604924385, 6826.453883689393, 6865.794026179223, 6884.414824739853, 6890.0, 6806.761763338359, 6870.896936545956, 6883.759068432681, 6904.4821638377325, 6916.20463646687, 6933.341332573397, 6951.131108611424, 6951.93048069523, 6960.33876781715, 6961.860762784716, 6722.932770672426, 6723.663816809238, 6727.2263689674355, 6734.8653026940165, 6738.0, 6502.349765023459, 6614.801555953137, 6632.1709786276715, 6635.535512514078, 6642.103316052271, 6907.998340240738, 6932.757353492603, 6937.479689023445, 6940.514164008471, 6944.062551555678, 4567.794449249858, 4635.6986795858165, 4642.698224615389, 4645.419322584677, 4648.093621743727, 6710.530262881747, 6711.664416779239, 6715.227748808754, 6716.5634233774645, 6723.562968407038, 6365.299817020032, 6552.049952756919, 6605.339466053356, 6605.735770569124, 6610.900836487361, 6543.083968244355, 6575.408213260829, 6578.868422631424, 6581.506387020897, 6600.60396376219, 6420.7431702731365, 6468.2561505427475, 6472.967635161794, 6473.320301368477, 6474.579152355271, 6591.439727623206, 6592.604443733391, 6595.769148079794, 6603.141591593062, 6609.801705948829, 5987.191729116687, 6136.693165341626, 6363.872722545616, 6418.486521078209, 6438.90341644885], "unit": "score", "name": "prototype.html", "value": 4889.662108002853}, {"lowerIsBetter": false, "replicates": [681.3969636871367, 795.9522428654285, 810.359815745561, 820.4912953968541, 920.1120918313828, 14091.0, 14418.783718244234, 14437.205953672545, 14442.855571444283, 14444.0, 12946.287954162517, 13817.240051797147, 13908.513202037931, 13934.0, 13956.860431395682, 900.3832374823266, 923.3259720404109, 924.482289917645, 925.2043242811177, 926.1155596405416, 904.1230006893336, 925.3568769705058, 930.9487978161198, 933.0855761353878, 933.9533023348839, 797.1510341486328, 970.5050424283596, 980.5734505490099, 983.2134292565954, 984.7981163861427, 957.1242313283337, 961.5336561767572, 964.6575465709677, 969.2827307792184, 969.5879251318162, 709.8154479835229, 717.1465955512975, 717.4045542200014, 717.4188906985306, 717.7129148340654, 13475.0, 13523.053386262965, 13543.525976590772, 13547.59357219285, 13549.932250338783, 14104.576862694135, 14350.210738409383, 14376.0, 14442.566722998326, 14454.566363009126, 10728.570857165781, 10815.242932994694, 10854.620088296952, 10985.560577576887, 10999.175061870312, 3927.8232479538487, 3960.4455376247347, 3973.7615743055508, 4004.179143275651, 4070.715049946505, 48134.518654813706, 49567.50432495665, 49583.256251156265, 49629.00741985176, 50878.0, 11073.280236784583, 11246.381449020382, 11266.605668801552, 11620.535178592761, 11677.824832627517, 19816.50458738514, 19892.303769368, 19914.103865326095, 19922.30271940504, 19925.20299188045, 8152.6331315090965, 8305.792355191048, 8371.748847534584, 8385.161483851565, 8593.656253749905, 4535.16099521583, 4570.200214962369, 4746.833860814855, 4759.904801903943, 4962.702237865739, 3408.0968543336035, 3449.99950014498, 3460.5501284833313, 3470.2712430389397, 3471.1322169457635, 561.3880869851881, 631.6557476175495, 652.7030201258416, 657.139147716493, 673.4376795375916, 659.5037781995126, 682.5904457325664, 717.6626985316892, 719.3310221494061, 742.550756792133, 8331.416800823885, 8613.956930215309, 8632.870506942401, 9240.260779137652, 9629.518524073768, 598.8353202869158, 644.9742010319628, 684.4455990647591, 708.7909066825299, 717.9676914538858, 4152.446245558959, 4384.298512238027, 4402.207602631493, 4465.665075119379, 4526.864194074183, 58760.7061964696, 59160.40839591635, 59208.0, 59356.10965835516, 59919.70040149859, 52432.737836310574, 52841.0, 53201.7339913298, 53349.0, 53787.462125379025, 45208.095838083056, 45894.31158532625, 46267.074658506644, 47475.5252447478, 48424.0, 8076.596170191585, 8215.465994710325, 8516.977962644522, 8687.131286871263, 8866.157715017063, 36251.27497450089, 36793.816030919676, 37399.87800365884, 37453.43819842759, 37808.810955945046, 42057.78971105125, 45250.0, 45425.31862022006, 46306.76846615745, 46523.0, 11283.605073822377, 11333.979941805277, 11393.715157121138, 11561.710957226136, 12288.016958643466, 11558.0, 11614.361210133524, 11710.765784684429, 12518.37408129608, 12639.87360126387, 11331.603393881174, 11426.828597570877, 11476.540938362707, 11509.654710358702, 11578.652640420802, 11453.541858325574, 11489.482973266056, 11494.195406321478, 11633.243839150766, 12035.578754743541, 10973.396463194282, 11503.079753619857, 11541.769164616828, 11547.20007127912, 11659.417029148679, 9742.171915387271, 9792.559334829808, 9947.353422027545, 10004.599816007569, 10223.0, 10438.843417348595, 10588.205884558844, 10689.251752377259, 10747.247692661438, 10845.13238940867], "unit": "score", "name": "yui.html", "value": 6724.686105985406}], "name": "dromaeo_css", "value": 7194.721066619231}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 104.0, 110.0, 111.0, 110.0, 98.0, 110.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 132.0, 154.0, 171.0, 127.0, 154.0, 165.0, 133.0, 163.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 162.0, 164.0, 160.0, 161.0, 166.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 74.0, 161.0, 76.0, 77.0, 78.0, 74.0, 160.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 93.0, 94.0, 93.0, 149.0, 91.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 54.0, 55.0, 55.0, 55.0, 56.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [85.0, 78.0, 79.0, 79.0, 78.0, 79.0, 79.0, 78.0, 85.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [109.0, 119.0, 111.0, 115.0, 112.0, 123.0, 121.0, 115.0, 111.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.3}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 152.0, 143.0, 147.0, 134.0, 135.0, 145.0, 157.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 71.0, 71.0, 67.0, 68.0, 68.0, 73.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1506.0}]} 09:56:09 INFO - Return code: 0 09:56:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:56:09 INFO - # TBPL SUCCESS # 09:56:09 INFO - Running post-action listener: _resource_record_post_action 09:56:09 INFO - Running post-run listener: _resource_record_post_run 09:56:10 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 497549312; Read time: 0; Write time: 1493208 09:56:10 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 223215616; Read time: 0; Write time: 952484 09:56:10 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 251162624; Read time: 0; Write time: 497756 09:56:10 INFO - Running post-run listener: _upload_blobber_files 09:56:10 INFO - Blob upload gear active. 09:56:10 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:56:10 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 09:56:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:56:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:56:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:12 INFO - (blobuploader) - INFO - Done attempting. 09:56:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:56:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:56:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:14 INFO - (blobuploader) - INFO - Done attempting. 09:56:14 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:14 INFO - Return code: 0 09:56:14 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:56:14 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad173f7837f150269f8c5fb7570eb08e94c4921cf2fb8c80c1094f13ee0afed20385588e34dfd2db0fe1e3036c27349a3104d71083ed456d2c9adccc7e8c326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572ee65516c1798ea79c4aa31f5420ed59564d1b4b364e610d1ad6b53bfa70c01e8190a70205a0cc8a6064e5e5ca189a5004b4fd3606e323f2ffaefb2ab02efe"} 09:56:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:56:14 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:56:14 INFO - Contents: 09:56:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad173f7837f150269f8c5fb7570eb08e94c4921cf2fb8c80c1094f13ee0afed20385588e34dfd2db0fe1e3036c27349a3104d71083ed456d2c9adccc7e8c326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572ee65516c1798ea79c4aa31f5420ed59564d1b4b364e610d1ad6b53bfa70c01e8190a70205a0cc8a6064e5e5ca189a5004b4fd3606e323f2ffaefb2ab02efe"} 09:56:14 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:14 INFO - Copying logs to upload dir... 09:56:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:56:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.878662 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-24 09:56:14.063096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:14.067045) ========= 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad173f7837f150269f8c5fb7570eb08e94c4921cf2fb8c80c1094f13ee0afed20385588e34dfd2db0fe1e3036c27349a3104d71083ed456d2c9adccc7e8c326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572ee65516c1798ea79c4aa31f5420ed59564d1b4b364e610d1ad6b53bfa70c01e8190a70205a0cc8a6064e5e5ca189a5004b4fd3606e323f2ffaefb2ab02efe"} build_url:https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad173f7837f150269f8c5fb7570eb08e94c4921cf2fb8c80c1094f13ee0afed20385588e34dfd2db0fe1e3036c27349a3104d71083ed456d2c9adccc7e8c326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/572ee65516c1798ea79c4aa31f5420ed59564d1b4b364e610d1ad6b53bfa70c01e8190a70205a0cc8a6064e5e5ca189a5004b4fd3606e323f2ffaefb2ab02efe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:14.091636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:14.091934) ========= 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=745a4373a2a16df560f216e000000264-1458837292.218187-157942928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:14.144289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 09:56:14.144566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 09:56:14.144843) ========= ========= Total master_lag: 0.28 =========