builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1456449118.76 results: success (0) buildid: 20160225143146 builduid: f2554bbaf6cd46e89f338ad779b3b6c1 revision: c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.758149) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.758578) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.758862) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009058 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.783845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.784135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.812364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.812631) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004743 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.866313) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.866596) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.866957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:58.870401) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 17:11:59-- 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% 221M=0s 2016-02-25 17:11:59 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:59.051730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:59.052016) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017609 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:11:59.103821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 17:11:59.104451) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a --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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 17:11:59,878 truncating revision to first 12 chars 2016-02-25 17:11:59,878 Setting DEBUG logging. 2016-02-25 17:11:59,878 attempt 1/10 2016-02-25 17:11:59,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c75bc39acae8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 17:12:00,614 unpacking tar archive at: fx-team-c75bc39acae8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.090924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 17:12:00.207233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 17:12:00.207537) ========= echo c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a'] 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a program finished with exit code 0 elapsedTime=0.004862 script_repo_revision: 'c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 17:12:00.262749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 17:12:00.263052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 17:12:00.275166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-25 17:12:00.275452) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:01 INFO - MultiFileLogger online at 20160225 17:12:01 in /builds/slave/test-pgo 17:12:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:12:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:12:01 INFO - {'append_to_log': False, 17:12:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:12:01 INFO - 'blob_upload_branch': 'Fx-Team', 17:12:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:12:01 INFO - 'branch': 'Fx-Team', 17:12:01 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:01 INFO - 'config_files': ('talos/linux_config.py',), 17:12:01 INFO - 'default_actions': ('clobber', 17:12:01 INFO - 'read-buildbot-config', 17:12:01 INFO - 'download-and-extract', 17:12:01 INFO - 'populate-webroot', 17:12:01 INFO - 'create-virtualenv', 17:12:01 INFO - 'install', 17:12:01 INFO - 'run-tests'), 17:12:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:01 INFO - 'download_minidump_stackwalk': True, 17:12:01 INFO - 'download_symbols': 'ondemand', 17:12:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:01 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:01 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:01 INFO - 'installer_path': 'installer.exe', 17:12:01 INFO - 'log_level': 'info', 17:12:01 INFO - 'log_name': 'talos', 17:12:01 INFO - 'log_to_console': True, 17:12:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:01 INFO - 'opt_config_files': (), 17:12:01 INFO - 'pip_index': False, 17:12:01 INFO - 'sps_profile': False, 17:12:01 INFO - 'sps_profile_interval': 0, 17:12:01 INFO - 'suite': 'dromaeojs', 17:12:01 INFO - 'system_bits': '32', 17:12:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:01 INFO - 'title': 'talos-linux64-ix-068', 17:12:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:01 INFO - 'use_talos_json': True, 17:12:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:12:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:01 INFO - 'work_dir': 'build'} 17:12:01 INFO - ##### 17:12:01 INFO - ##### Running clobber step. 17:12:01 INFO - ##### 17:12:01 INFO - Running pre-action listener: _resource_record_pre_action 17:12:01 INFO - Running main action method: clobber 17:12:01 INFO - rmtree: /builds/slave/test-pgo/build 17:12:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:12:02 INFO - Running post-action listener: _resource_record_post_action 17:12:02 INFO - ##### 17:12:02 INFO - ##### Running read-buildbot-config step. 17:12:02 INFO - ##### 17:12:02 INFO - Running pre-action listener: _resource_record_pre_action 17:12:02 INFO - Running main action method: read_buildbot_config 17:12:02 INFO - Using buildbot properties: 17:12:02 INFO - { 17:12:02 INFO - "project": "", 17:12:02 INFO - "product": "firefox", 17:12:02 INFO - "script_repo_revision": "production", 17:12:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:12:02 INFO - "repository": "", 17:12:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:12:02 INFO - "buildid": "20160225143146", 17:12:02 INFO - "pgo_build": "True", 17:12:02 INFO - "basedir": "/builds/slave/test-pgo", 17:12:02 INFO - "buildnumber": 670, 17:12:02 INFO - "slavename": "talos-linux64-ix-068", 17:12:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:12:02 INFO - "platform": "ubuntu64_hw", 17:12:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:12:02 INFO - "branch": "fx-team", 17:12:02 INFO - "repo_path": "integration/fx-team", 17:12:02 INFO - "revision": "c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a", 17:12:02 INFO - "stage_platform": "linux64-pgo", 17:12:02 INFO - "builduid": "f2554bbaf6cd46e89f338ad779b3b6c1", 17:12:02 INFO - "slavebuilddir": "test" 17:12:02 INFO - } 17:12:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:12:02 INFO - Running post-action listener: _resource_record_post_action 17:12:02 INFO - ##### 17:12:02 INFO - ##### Running download-and-extract step. 17:12:02 INFO - ##### 17:12:02 INFO - Running pre-action listener: _resource_record_pre_action 17:12:02 INFO - Running main action method: download_and_extract 17:12:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:02 INFO - https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/test_packages.json 17:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/test_packages.json 17:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:12:04 INFO - Downloaded 1448 bytes. 17:12:04 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:12:04 INFO - Using the following test package requirements: 17:12:04 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:12:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:12:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'jsshell-linux-x86_64.zip'], 17:12:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:12:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:12:04 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:12:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:12:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:12:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:12: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')]} 17:12:04 INFO - https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:12:05 INFO - Downloaded 23370605 bytes. 17:12:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:12:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:12:06 INFO - Return code: 0 17:12:06 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:12:06 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')]} 17:12:06 INFO - https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:12:08 INFO - Downloaded 23370605 bytes. 17:12:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:12:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:12:10 INFO - Return code: 0 17:12:10 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')]} 17:12:10 INFO - https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:12:11 INFO - Downloaded 10713410 bytes. 17:12:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:12:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:12:11 INFO - Return code: 0 17:12: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')]} 17:12:11 INFO - https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:12:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:12:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:12:13 INFO - Downloaded 56629666 bytes. 17:12:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:12:13 INFO - mkdir: /builds/slave/test-pgo/properties 17:12:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:12:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:12:13 INFO - Contents: 17:12:13 INFO - build_url:https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:12:14 INFO - Running post-action listener: _resource_record_post_action 17:12:14 INFO - Running post-action listener: set_extra_try_arguments 17:12:14 INFO - ##### 17:12:14 INFO - ##### Running populate-webroot step. 17:12:14 INFO - ##### 17:12:14 INFO - Running pre-action listener: _resource_record_pre_action 17:12:14 INFO - Running main action method: populate_webroot 17:12:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:14 INFO - '--tppagecycles', 17:12:14 INFO - '7'], 17:12:14 INFO - 'tests': ['tsvgm']}}, 17:12:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:12:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:12:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'tests': ['damp', 'tps']}, 17:12:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['damp', 'tps']}, 17:12:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:12:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:14 INFO - 'other': {'tests': ['a11yr', 17:12:14 INFO - 'ts_paint', 17:12:14 INFO - 'tpaint', 17:12:14 INFO - 'sessionrestore', 17:12:14 INFO - 'sessionrestore_no_auto_restore']}, 17:12:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['a11yr', 17:12:14 INFO - 'ts_paint', 17:12:14 INFO - 'tpaint', 17:12:14 INFO - 'sessionrestore', 17:12:14 INFO - 'sessionrestore_no_auto_restore']}, 17:12:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['a11yr', 17:12:14 INFO - 'ts_paint', 17:12:14 INFO - 'tpaint', 17:12:14 INFO - 'sessionrestore', 17:12:14 INFO - 'sessionrestore_no_auto_restore']}, 17:12:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['a11yr', 17:12:14 INFO - 'ts_paint', 17:12:14 INFO - 'tpaint', 17:12:14 INFO - 'sessionrestore', 17:12:14 INFO - 'sessionrestore_no_auto_restore']}, 17:12:14 INFO - 'other_l64': {'tests': ['a11yr', 17:12:14 INFO - 'ts_paint', 17:12:14 INFO - 'tpaint', 17:12:14 INFO - 'sessionrestore', 17:12:14 INFO - 'sessionrestore_no_auto_restore']}, 17:12:14 INFO - 'other_nol64': {'tests': ['a11yr', 17:12:14 INFO - 'ts_paint', 17:12:14 INFO - 'tpaint', 17:12:14 INFO - 'sessionrestore', 17:12:14 INFO - 'sessionrestore_no_auto_restore']}, 17:12:14 INFO - 'svgr': {'tests': ['tsvgx', 17:12:14 INFO - 'tsvgr_opacity', 17:12:14 INFO - 'tart', 17:12:14 INFO - 'tscrollx', 17:12:14 INFO - 'cart']}, 17:12:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['tsvgx', 17:12:14 INFO - 'tsvgr_opacity', 17:12:14 INFO - 'tart', 17:12:14 INFO - 'tscrollx', 17:12:14 INFO - 'cart']}, 17:12:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'tests': ['tp5o']}, 17:12:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'talos_options': ['--e10s'], 17:12:14 INFO - 'tests': ['tp5o']}, 17:12:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'talos_options': ['--xperf_path', 17:12:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:14 INFO - 'tests': ['tp5n']}, 17:12:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:14 INFO - 'talos_options': ['--e10s', 17:12:14 INFO - '--xperf_path', 17:12:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:14 INFO - 'tests': ['tp5n']}}, 17:12:14 INFO - 'talos.zip': {'path': '', 17:12:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:14 INFO - Running post-action listener: _resource_record_post_action 17:12:14 INFO - ##### 17:12:14 INFO - ##### Running create-virtualenv step. 17:12:14 INFO - ##### 17:12:14 INFO - Running pre-action listener: _resource_record_pre_action 17:12:14 INFO - Running main action method: create_virtualenv 17:12:14 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:12:14 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 17:12:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:12:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:14 INFO - Using real prefix '/usr' 17:12:14 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:12:15 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:17 INFO - Installing pip.................done. 17:12:17 INFO - Return code: 0 17:12:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:12:17 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')]} 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:17 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')]} 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:17 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:17 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 17:12:17 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 17:12:17 INFO - Using env: {'DISPLAY': ':0', 17:12:17 INFO - 'HOME': '/home/cltbld', 17:12:17 INFO - 'LANG': 'en_US.UTF-8', 17:12:17 INFO - 'LANGUAGE': 'en_US:en', 17:12:17 INFO - 'LOGNAME': 'cltbld', 17:12:17 INFO - 'MAIL': '/var/mail/cltbld', 17:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:17 INFO - 'MOZ_NO_REMOTE': '1', 17:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:17 INFO - 'NO_EM_RESTART': '1', 17:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:17 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:17 INFO - 'SHELL': '/bin/bash', 17:12:17 INFO - 'SHLVL': '1', 17:12:17 INFO - 'TERM': 'linux', 17:12:17 INFO - 'TMOUT': '86400', 17:12:17 INFO - 'USER': 'cltbld', 17:12:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:17 INFO - '_': '/tools/buildbot/bin/python'} 17:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:17 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 17:12:17 INFO - Cleaning up... 17:12:17 INFO - Return code: 0 17:12:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:12:17 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')]} 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:17 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')]} 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:17 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:17 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 17:12:17 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 17:12:17 INFO - Using env: {'DISPLAY': ':0', 17:12:17 INFO - 'HOME': '/home/cltbld', 17:12:17 INFO - 'LANG': 'en_US.UTF-8', 17:12:17 INFO - 'LANGUAGE': 'en_US:en', 17:12:17 INFO - 'LOGNAME': 'cltbld', 17:12:17 INFO - 'MAIL': '/var/mail/cltbld', 17:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:17 INFO - 'MOZ_NO_REMOTE': '1', 17:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:17 INFO - 'NO_EM_RESTART': '1', 17:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:17 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:17 INFO - 'SHELL': '/bin/bash', 17:12:17 INFO - 'SHLVL': '1', 17:12:17 INFO - 'TERM': 'linux', 17:12:17 INFO - 'TMOUT': '86400', 17:12:17 INFO - 'USER': 'cltbld', 17:12:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:17 INFO - '_': '/tools/buildbot/bin/python'} 17:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:17 INFO - Downloading/unpacking psutil>=0.7.1 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:19 INFO - Installing collected packages: psutil 17:12:19 INFO - Running setup.py install for psutil 17:12:19 INFO - building 'psutil._psutil_linux' extension 17:12:19 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 17:12:19 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 17:12:19 INFO - building 'psutil._psutil_posix' extension 17:12:19 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 17:12:20 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 17:12:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:20 INFO - Successfully installed psutil 17:12:20 INFO - Cleaning up... 17:12:20 INFO - Return code: 0 17:12:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:12:20 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')]} 17:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:20 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')]} 17:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:20 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:20 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 17:12:20 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 17:12:20 INFO - Using env: {'DISPLAY': ':0', 17:12:20 INFO - 'HOME': '/home/cltbld', 17:12:20 INFO - 'LANG': 'en_US.UTF-8', 17:12:20 INFO - 'LANGUAGE': 'en_US:en', 17:12:20 INFO - 'LOGNAME': 'cltbld', 17:12:20 INFO - 'MAIL': '/var/mail/cltbld', 17:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:20 INFO - 'MOZ_NO_REMOTE': '1', 17:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:20 INFO - 'NO_EM_RESTART': '1', 17:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:20 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:20 INFO - 'SHELL': '/bin/bash', 17:12:20 INFO - 'SHLVL': '1', 17:12:20 INFO - 'TERM': 'linux', 17:12:20 INFO - 'TMOUT': '86400', 17:12:20 INFO - 'USER': 'cltbld', 17:12:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:20 INFO - '_': '/tools/buildbot/bin/python'} 17:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:12:20 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 17:12:20 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 17:12:20 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 17:12:20 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 17:12:20 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 17:12:20 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 17:12:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:12:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:12:22 INFO - Installing collected packages: mozsystemmonitor 17:12:22 INFO - Running setup.py install for mozsystemmonitor 17:12:22 INFO - Successfully installed mozsystemmonitor 17:12:22 INFO - Cleaning up... 17:12:22 INFO - Return code: 0 17:12:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:12:22 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')]} 17:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:22 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')]} 17:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:22 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:22 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 17:12:22 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 17:12:22 INFO - Using env: {'DISPLAY': ':0', 17:12:22 INFO - 'HOME': '/home/cltbld', 17:12:22 INFO - 'LANG': 'en_US.UTF-8', 17:12:22 INFO - 'LANGUAGE': 'en_US:en', 17:12:22 INFO - 'LOGNAME': 'cltbld', 17:12:22 INFO - 'MAIL': '/var/mail/cltbld', 17:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:22 INFO - 'MOZ_NO_REMOTE': '1', 17:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:22 INFO - 'NO_EM_RESTART': '1', 17:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:22 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:22 INFO - 'SHELL': '/bin/bash', 17:12:22 INFO - 'SHLVL': '1', 17:12:22 INFO - 'TERM': 'linux', 17:12:22 INFO - 'TMOUT': '86400', 17:12:22 INFO - 'USER': 'cltbld', 17:12:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:22 INFO - '_': '/tools/buildbot/bin/python'} 17:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:22 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:22 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 17:12:22 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 17:12:22 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 17:12:22 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 17:12:22 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 17:12:22 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 17:12:24 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:24 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 17:12:24 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 17:12:24 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 17:12:24 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 17:12:24 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 17:12:24 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 17:12:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:12:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12:24 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 17:12:24 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 17:12:24 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 17:12:24 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 17:12:24 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 17:12:24 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 17:12:25 INFO - Downloading docopt-0.6.1.tar.gz 17:12:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:25 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:25 INFO - Running setup.py install for blobuploader 17:12:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:25 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:12:25 INFO - Running setup.py install for requests 17:12:25 INFO - Running setup.py install for docopt 17:12:25 INFO - Successfully installed blobuploader requests docopt 17:12:25 INFO - Cleaning up... 17:12:25 INFO - Return code: 0 17:12:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:12:25 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')]} 17:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:25 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')]} 17:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:25 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:25 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 17:12:25 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 17:12:25 INFO - Using env: {'DISPLAY': ':0', 17:12:25 INFO - 'HOME': '/home/cltbld', 17:12:25 INFO - 'LANG': 'en_US.UTF-8', 17:12:25 INFO - 'LANGUAGE': 'en_US:en', 17:12:25 INFO - 'LOGNAME': 'cltbld', 17:12:25 INFO - 'MAIL': '/var/mail/cltbld', 17:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:25 INFO - 'MOZ_NO_REMOTE': '1', 17:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:25 INFO - 'NO_EM_RESTART': '1', 17:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:25 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:25 INFO - 'SHELL': '/bin/bash', 17:12:25 INFO - 'SHLVL': '1', 17:12:25 INFO - 'TERM': 'linux', 17:12:25 INFO - 'TMOUT': '86400', 17:12:25 INFO - 'USER': 'cltbld', 17:12:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:25 INFO - '_': '/tools/buildbot/bin/python'} 17:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:12:26 INFO - Running setup.py (path:/tmp/pip-hO6FXN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:12:26 INFO - Running setup.py (path:/tmp/pip-OZqv9Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:12:26 INFO - Running setup.py (path:/tmp/pip-9RkdgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:12:26 INFO - Running setup.py (path:/tmp/pip-1rrZ5p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:12:26 INFO - Running setup.py (path:/tmp/pip-Nk9cKR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:12:26 INFO - Running setup.py (path:/tmp/pip-xlHwm1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:12:26 INFO - Running setup.py (path:/tmp/pip-7l3t0u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:12:26 INFO - Running setup.py (path:/tmp/pip-NY4Cpu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:12:26 INFO - Running setup.py (path:/tmp/pip-8GR8UX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:12:26 INFO - Running setup.py (path:/tmp/pip-svaEe0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:12:26 INFO - Running setup.py (path:/tmp/pip-GDit9T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:12:26 INFO - Running setup.py (path:/tmp/pip-7Qprb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:12:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:12:26 INFO - Running setup.py (path:/tmp/pip-i3Vw5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:12:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:12:27 INFO - Running setup.py (path:/tmp/pip-Zpvuzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:12:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:12:27 INFO - Running setup.py (path:/tmp/pip-V6mmJZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:12:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:12:27 INFO - Running setup.py (path:/tmp/pip-HXEoKA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:12:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:12:27 INFO - Running setup.py (path:/tmp/pip-9lmGSm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:12:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:27 INFO - Running setup.py install for manifestparser 17:12:27 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:12:27 INFO - Running setup.py install for mozcrash 17:12:27 INFO - Running setup.py install for mozdebug 17:12:27 INFO - Running setup.py install for mozdevice 17:12:27 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:12:27 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:12:27 INFO - Running setup.py install for mozfile 17:12:27 INFO - Running setup.py install for mozhttpd 17:12:27 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:12:27 INFO - Running setup.py install for mozinfo 17:12:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Running setup.py install for mozInstall 17:12:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Running setup.py install for mozleak 17:12:28 INFO - Running setup.py install for mozlog 17:12:28 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Running setup.py install for moznetwork 17:12:28 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Running setup.py install for mozprocess 17:12:28 INFO - Running setup.py install for mozprofile 17:12:28 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Running setup.py install for mozrunner 17:12:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:12:28 INFO - Running setup.py install for mozscreenshot 17:12:28 INFO - Running setup.py install for moztest 17:12:29 INFO - Running setup.py install for mozversion 17:12:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:12:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:29 INFO - Cleaning up... 17:12:29 INFO - Return code: 0 17:12:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:12:29 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')]} 17:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:29 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')]} 17:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:29 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:29 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 17:12:29 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 17:12:29 INFO - Using env: {'DISPLAY': ':0', 17:12:29 INFO - 'HOME': '/home/cltbld', 17:12:29 INFO - 'LANG': 'en_US.UTF-8', 17:12:29 INFO - 'LANGUAGE': 'en_US:en', 17:12:29 INFO - 'LOGNAME': 'cltbld', 17:12:29 INFO - 'MAIL': '/var/mail/cltbld', 17:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:29 INFO - 'MOZ_NO_REMOTE': '1', 17:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:29 INFO - 'NO_EM_RESTART': '1', 17:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:29 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:29 INFO - 'SHELL': '/bin/bash', 17:12:29 INFO - 'SHLVL': '1', 17:12:29 INFO - 'TERM': 'linux', 17:12:29 INFO - 'TMOUT': '86400', 17:12:29 INFO - 'USER': 'cltbld', 17:12:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:29 INFO - '_': '/tools/buildbot/bin/python'} 17:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:12:29 INFO - Running setup.py (path:/tmp/pip-Y4L87n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:12:29 INFO - Running setup.py (path:/tmp/pip-AHs359-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:12:29 INFO - Running setup.py (path:/tmp/pip-Rv7XrG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:12:29 INFO - Running setup.py (path:/tmp/pip-yyzkaT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:12:29 INFO - Running setup.py (path:/tmp/pip-9VFx90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:12:29 INFO - Running setup.py (path:/tmp/pip-LSHZLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:12:29 INFO - Running setup.py (path:/tmp/pip-S7hjft-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:12:29 INFO - Running setup.py (path:/tmp/pip-01y94P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:12:29 INFO - Running setup.py (path:/tmp/pip-VSVnLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:12:29 INFO - Running setup.py (path:/tmp/pip-y7AKkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:12:30 INFO - Running setup.py (path:/tmp/pip-iXAuUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:12:30 INFO - Running setup.py (path:/tmp/pip-YuxNaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:12:30 INFO - Running setup.py (path:/tmp/pip-ZhpSuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:12:30 INFO - Running setup.py (path:/tmp/pip-0VIxAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:12:30 INFO - Running setup.py (path:/tmp/pip-_IJ5q7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:12:30 INFO - Running setup.py (path:/tmp/pip-6wsZMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:12:30 INFO - Running setup.py (path:/tmp/pip-XDeIlu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:12:30 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)) 17:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:30 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)) 17:12:30 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)) 17:12:30 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)) 17:12:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:30 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 17:12:30 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 17:12:30 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 17:12:30 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 17:12:30 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 17:12:30 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 17:12:32 INFO - Downloading blessings-1.6.tar.gz 17:12:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:32 INFO - Installing collected packages: blessings 17:12:32 INFO - Running setup.py install for blessings 17:12:32 INFO - Successfully installed blessings 17:12:32 INFO - Cleaning up... 17:12:32 INFO - Return code: 0 17:12:32 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:12:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:12:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:12:32 INFO - Reading from file tmpfile_stdout 17:12:32 INFO - Current package versions: 17:12:32 INFO - argparse == 1.2.1 17:12:32 INFO - blessings == 1.6 17:12:32 INFO - blobuploader == 1.2.4 17:12:32 INFO - docopt == 0.6.1 17:12:32 INFO - manifestparser == 1.1 17:12:32 INFO - mozInstall == 1.12 17:12:32 INFO - mozcrash == 0.16 17:12:32 INFO - mozdebug == 0.1 17:12:32 INFO - mozdevice == 0.48 17:12:32 INFO - mozfile == 1.2 17:12:32 INFO - mozhttpd == 0.7 17:12:32 INFO - mozinfo == 0.9 17:12:32 INFO - mozleak == 0.1 17:12:32 INFO - mozlog == 3.1 17:12:32 INFO - moznetwork == 0.27 17:12:32 INFO - mozprocess == 0.22 17:12:32 INFO - mozprofile == 0.28 17:12:32 INFO - mozrunner == 6.11 17:12:32 INFO - mozscreenshot == 0.1 17:12:32 INFO - mozsystemmonitor == 0.0 17:12:32 INFO - moztest == 0.7 17:12:32 INFO - mozversion == 1.4 17:12:32 INFO - psutil == 3.1.1 17:12:32 INFO - requests == 1.2.3 17:12:32 INFO - wsgiref == 0.1.2 17:12:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:12:32 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')]} 17:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:32 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')]} 17:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:32 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:32 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 17:12:32 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 17:12:32 INFO - Using env: {'DISPLAY': ':0', 17:12:32 INFO - 'HOME': '/home/cltbld', 17:12:32 INFO - 'LANG': 'en_US.UTF-8', 17:12:32 INFO - 'LANGUAGE': 'en_US:en', 17:12:32 INFO - 'LOGNAME': 'cltbld', 17:12:32 INFO - 'MAIL': '/var/mail/cltbld', 17:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:32 INFO - 'MOZ_NO_REMOTE': '1', 17:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:32 INFO - 'NO_EM_RESTART': '1', 17:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:32 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:32 INFO - 'SHELL': '/bin/bash', 17:12:32 INFO - 'SHLVL': '1', 17:12:32 INFO - 'TERM': 'linux', 17:12:32 INFO - 'TMOUT': '86400', 17:12:32 INFO - 'USER': 'cltbld', 17:12:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:32 INFO - '_': '/tools/buildbot/bin/python'} 17:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 INFO - Cleaning up... 17:12:33 INFO - Return code: 0 17:12:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:12:33 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')]} 17:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 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')]} 17:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:33 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 17:12:33 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 17:12:33 INFO - Using env: {'DISPLAY': ':0', 17:12:33 INFO - 'HOME': '/home/cltbld', 17:12:33 INFO - 'LANG': 'en_US.UTF-8', 17:12:33 INFO - 'LANGUAGE': 'en_US:en', 17:12:33 INFO - 'LOGNAME': 'cltbld', 17:12:33 INFO - 'MAIL': '/var/mail/cltbld', 17:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:33 INFO - 'MOZ_NO_REMOTE': '1', 17:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:33 INFO - 'NO_EM_RESTART': '1', 17:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:33 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:33 INFO - 'SHELL': '/bin/bash', 17:12:33 INFO - 'SHLVL': '1', 17:12:33 INFO - 'TERM': 'linux', 17:12:33 INFO - 'TMOUT': '86400', 17:12:33 INFO - 'USER': 'cltbld', 17:12:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:33 INFO - '_': '/tools/buildbot/bin/python'} 17:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:33 INFO - Downloading/unpacking jsonschema 17:12:33 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 17:12:33 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 17:12:33 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 17:12:33 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 17:12:33 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 17:12:33 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 17:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:35 INFO - Downloading/unpacking functools32 (from jsonschema) 17:12:35 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 17:12:35 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 17:12:35 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 17:12:35 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 17:12:35 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 17:12:35 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 17:12:35 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:35 INFO - warning: no files found matching '*.txt' 17:12:35 INFO - no previously-included directories found matching 'build' 17:12:35 INFO - no previously-included directories found matching 'dist' 17:12:35 INFO - no previously-included directories found matching '.git*' 17:12:35 INFO - Installing collected packages: jsonschema, functools32 17:12:35 INFO - Running setup.py install for functools32 17:12:35 INFO - warning: no files found matching '*.txt' 17:12:35 INFO - no previously-included directories found matching 'build' 17:12:35 INFO - no previously-included directories found matching 'dist' 17:12:35 INFO - no previously-included directories found matching '.git*' 17:12:35 INFO - Successfully installed jsonschema functools32 17:12:35 INFO - Cleaning up... 17:12:35 INFO - Return code: 0 17:12:35 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:12: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')]} 17:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:35 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 0x7f50e90acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', '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 17:12:35 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 17:12:35 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 17:12:35 INFO - Using env: {'DISPLAY': ':0', 17:12:35 INFO - 'HOME': '/home/cltbld', 17:12:35 INFO - 'LANG': 'en_US.UTF-8', 17:12:35 INFO - 'LANGUAGE': 'en_US:en', 17:12:35 INFO - 'LOGNAME': 'cltbld', 17:12:35 INFO - 'MAIL': '/var/mail/cltbld', 17:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:35 INFO - 'MOZ_NO_REMOTE': '1', 17:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:35 INFO - 'NO_EM_RESTART': '1', 17:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:35 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:35 INFO - 'SHELL': '/bin/bash', 17:12:35 INFO - 'SHLVL': '1', 17:12:35 INFO - 'TERM': 'linux', 17:12:35 INFO - 'TMOUT': '86400', 17:12:35 INFO - 'USER': 'cltbld', 17:12:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:35 INFO - '_': '/tools/buildbot/bin/python'} 17:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:35 INFO - Downloading/unpacking flake8 17:12:35 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 17:12:35 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 17:12:35 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 17:12:35 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 17:12:35 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 17:12:35 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 17:12:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:12:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:12:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:12:38 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 17:12:38 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 17:12:38 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 17:12:38 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 17:12:38 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 17:12:38 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 17:12:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:12:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:38 INFO - no previously-included directories found matching 'docs/_build' 17:12:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:12:38 INFO - Running setup.py install for pep8 17:12:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:38 INFO - no previously-included directories found matching 'docs/_build' 17:12:38 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:12:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:12:38 INFO - Cleaning up... 17:12:38 INFO - Return code: 0 17:12:38 INFO - Running post-action listener: _resource_record_post_action 17:12:38 INFO - Running post-action listener: _start_resource_monitoring 17:12:38 INFO - Starting resource monitoring. 17:12:38 INFO - ##### 17:12:38 INFO - ##### Running install step. 17:12:38 INFO - ##### 17:12:38 INFO - Running pre-action listener: _resource_record_pre_action 17:12:38 INFO - Running main action method: install 17:12:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:12:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:12:38 INFO - Reading from file tmpfile_stdout 17:12:38 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:12:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:12:38 INFO - Reading from file tmpfile_stdout 17:12:38 INFO - Output received: 17:12:38 INFO - Usage: mozinstall [options] installer 17:12:38 INFO - Options: 17:12:38 INFO - -h, --help show this help message and exit 17:12:38 INFO - -d DEST, --destination=DEST 17:12:38 INFO - Directory to install application into. [default: 17:12:38 INFO - "/builds/slave/test-pgo"] 17:12:38 INFO - --app=APP Application being installed. [default: firefox] 17:12:38 INFO - mkdir: /builds/slave/test-pgo/build/application 17:12:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:12:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:12:55 INFO - Reading from file tmpfile_stdout 17:12:55 INFO - Output received: 17:12:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:12:55 INFO - Running post-action listener: _resource_record_post_action 17:12:55 INFO - ##### 17:12:55 INFO - ##### Running run-tests step. 17:12:55 INFO - ##### 17:12:55 INFO - Running pre-action listener: _resource_record_pre_action 17:12:55 INFO - Running main action method: run_tests 17:12:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:12:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:12:55 INFO - Python 2.7.3 17:12:55 INFO - Return code: 0 17:12:55 INFO - grabbing minidump binary from tooltool 17:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:55 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 0x282a8c0>, '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 0x282b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282bc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:12:55 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 17:12:55 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 17:12:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:55 INFO - Return code: 0 17:12:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:12:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:12:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:12:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:12:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:12:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:12:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:12:56 INFO - Return code: 0 17:12:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 17:12:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 17:12:56 INFO - Using env: {'DISPLAY': ':0', 17:12:56 INFO - 'HOME': '/home/cltbld', 17:12:56 INFO - 'LANG': 'en_US.UTF-8', 17:12:56 INFO - 'LANGUAGE': 'en_US:en', 17:12:56 INFO - 'LOGNAME': 'cltbld', 17:12:56 INFO - 'MAIL': '/var/mail/cltbld', 17:12:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:12:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:56 INFO - 'MOZ_NO_REMOTE': '1', 17:12:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:56 INFO - 'NO_EM_RESTART': '1', 17:12:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:56 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:12:56 INFO - 'SHELL': '/bin/bash', 17:12:56 INFO - 'SHLVL': '1', 17:12:56 INFO - 'TERM': 'linux', 17:12:56 INFO - 'TMOUT': '86400', 17:12:56 INFO - 'USER': 'cltbld', 17:12:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260', 17:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:56 INFO - '_': '/tools/buildbot/bin/python'} 17:12:56 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 17:12:56 INFO - mozversion application_buildid: 20160225143146 17:12:56 INFO - mozversion application_changeset: c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a 17:12:56 INFO - mozversion application_display_name: Nightly 17:12:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:56 INFO - mozversion application_name: Firefox 17:12:56 INFO - mozversion application_remotingname: firefox 17:12:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:12:56 INFO - mozversion application_vendor: Mozilla 17:12:56 INFO - mozversion application_version: 47.0a1 17:12:56 INFO - mozversion platform_buildid: 20160225143146 17:12:56 INFO - mozversion platform_changeset: c75bc39acae8f6dc6f66cf3e479fc2ddd301c08a 17:12:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:12:56 INFO - mozversion platform_version: 47.0a1 17:12:56 INFO - using testdate: 1456449176 17:12:56 INFO - actual date: 1456449176 17:12:56 INFO - starting webserver on 'localhost:45876' 17:12:56 INFO - SUITE-START | Running 2 tests 17:12:56 INFO - TEST-START | dromaeo_css 17:12:56 INFO - operating with platform_type : linux_ 17:12:56 INFO - Initialising browser for dromaeo_css test... 17:12:56 INFO - TEST-INFO | started process 31514 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcHMRRh/profile http://localhost:45876/getInfo.html) 17:13:00 INFO - PROCESS | 31514 | __metrics Screen width/height:1600/1200 17:13:00 INFO - PROCESS | 31514 | colorDepth:24 17:13:00 INFO - PROCESS | 31514 | Browser inner width/height: 1024/697 17:13:00 INFO - PROCESS | 31514 | __metrics 17:13:01 INFO - PROCESS | 31514 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:02 INFO - TEST-INFO | 31514: exit 0 17:13:02 INFO - Browser initialized. 17:13:02 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:02 INFO - TEST-INFO | started process 31610 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcHMRRh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:14 INFO - PROCESS | 31610 | RSS: Main: 147771392 17:13:14 INFO - PROCESS | 31610 | 17:14:05 INFO - PROCESS | 31610 | 1456449245917 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] 17:16:13 INFO - PROCESS | 31610 | Cycle 1(1): loaded http://localhost:45876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45876/tests/dromaeo/cssquery-ext.html) 17:16:15 INFO - PROCESS | 31610 | RSS: Main: 307462144 17:16:15 INFO - PROCESS | 31610 | 17:19:17 INFO - PROCESS | 31610 | Cycle 1(1): loaded http://localhost:45876/tests/dromaeo/cssquery-ext.html (next: http://localhost:45876/tests/dromaeo/cssquery-jquery.html) 17:19:17 INFO - PROCESS | 31610 | RSS: Main: 233631744 17:19:17 INFO - PROCESS | 31610 | 17:22:19 INFO - PROCESS | 31610 | Cycle 1(1): loaded http://localhost:45876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45876/tests/dromaeo/cssquery-mootools.html) 17:22:20 INFO - PROCESS | 31610 | RSS: Main: 230998016 17:22:20 INFO - PROCESS | 31610 | 17:25:22 INFO - PROCESS | 31610 | Cycle 1(1): loaded http://localhost:45876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45876/tests/dromaeo/cssquery-prototype.html) 17:25:22 INFO - PROCESS | 31610 | RSS: Main: 213872640 17:25:22 INFO - PROCESS | 31610 | 17:28:25 INFO - PROCESS | 31610 | Cycle 1(1): loaded http://localhost:45876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45876/tests/dromaeo/cssquery-yui.html) 17:28:26 INFO - PROCESS | 31610 | RSS: Main: 219107328 17:28:26 INFO - PROCESS | 31610 | 17:31:28 INFO - PROCESS | 31610 | Cycle 1(1): loaded http://localhost:45876/tests/dromaeo/cssquery-yui.html (next: http://localhost:45876/tests/dromaeo/cssquery-dojo.html) 17:31:29 INFO - PROCESS | 31610 | RSS: Main: 251064320 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | __start_tp_report 17:31:29 INFO - PROCESS | 31610 | _x_x_mozilla_page_load 17:31:29 INFO - PROCESS | 31610 | _x_x_mozilla_page_load_details 17:31:29 INFO - PROCESS | 31610 | |i|pagename|runs| 17:31:29 INFO - PROCESS | 31610 | |0;dojo.html;3100.829454380009;3125.2030732163294;3155.9684403155975;3166.461701510744;3197.728193103587;4934;5000.424951130621;5041.621878359119;5055.014272216915;5075.264086707425;4955.554000139987;4969.5030496950285;4990.0518901408705;5001.349824522816;5152.716600586966;4520.751358675271;4555.20283950309;4586.770661466921;4597.195490789115;4715.90568188636;4576;4587.403637527117;4641.396618439599;4650.883727906796;4702.459217190016;4622.375979242793;4655.278431843053;4657.091867085919;4668.813247470097;4690.859274221779;4656.394668693082;4665.813367465297;4671.532846715335;4691.038337140878;4714.575688188045;4507.932381014288;4605.516420775803;4642.86071417858;4724.71651700899;4736.5026672199265;4839.758012099416;4873.31773551703;4886.951130488721;4888.291197776338;4922.384701912261;5356.250124982505;5361.222622719683;5377.381601115882;5384.7846086156505;5398.973005134989;5272.841814745525;5442.074847275972;5512.724363781835;5559.555235581144;5587.078132108238;5088.109580823341;5111.897762044776;5116.488351164891;5117.181250999822;5117.692938423706;5292.259083728281;5528.253685752372;5535.723213839292;5536.335639723259;5541;5281.973590132025;5337.572994160458;5359.624826262202;5397.649152805055;5413.729313534308;5351.277577527062;5357.4106848246665;5358.812645484778;5360.973195133999;5365.382980957162;5278.604104692164;5328.653637513549;5333.120035194227;5392.218128371364;5415.972920135374;5438.755256013489;5452.6183167177915;5471.343438787371;5476.17857321405;5515.338159420895;4288.313869780883;4310.439642846472;4315.395844581761;4315.762633055212;4350.195213885441;3753.1930634913624;3793.2982398256413;3850.306944749972;3883.475730776309;3892.2215556888737;5067.87330316745;5072.391313042459;5109.6678715883345;5134.383873935151;5161.5870730341485;5394.298741163623;5410.540104091117;5410.810621628224;5415.539679127318;5452.372977107604;4988.625853061035;5030.899382012412;5058.519440653132;5096.439391666913;5168.04391187624;4682.578567928835;4697;4702.435707715028;4702.506236845151;4740.620750340034;5726.455986681259;5748.5688573357165;5751.1085781703905;5755.539556835443;5772.538196944234;5217.582593392595;5359.276497672764;5442.510174084351;5448.645838020675;5455.427180146027;5729.197912292366;5737.885242295214;5745.2818397700285;5745.97127014379;5796.681182535001;5371.704556249444;5390.97304513475;5397.190421436816;5398.433164517669;5399.9460005401015;5359.088954877602;5441.075017247156;5473.28847249855;5475.863103422446;5534.169874518693;5200.60995425337;5244.187150991603;5250.553702935294;5253.658512196695;5272.209168624737;5264.420913699567;5273.947260527499;5277.4194838566955;5306.310179676618;5397.379301380392;5225.372955245395;5274;5276.894462110813;5277.15565509532;5315.893682126413;5340.732963351895;5351.143816989419;5365.141577347606;5365.248865158959;5417.458254174551;5111.923321150261;5174.14626586609;5265.447128051653;5272.103742363884;5324.9733751331 17:31:29 INFO - PROCESS | 31610 | |1;ext.html;501.3607650245936;502.2466300549176;512.3774613844181;518.1916210711289;541.3855274263709;29220.415591688154;37502.0624484388;38150.809245953766;38207;38314.233715325674;41565.58434415655;41924.79037604816;41980.37029444553;42049.57950420495;42068.789656051755;8478.618462169217;8673.696420625249;8688.695895643654;8691.739247822576;8700.347473939448;8443.873341899876;8557.315414766836;8572.571371431435;8583.05586385497;8586.656533738644;8548.871766923501;8816.515091669955;8824.161704638049;8832.558372081403;8833.51415672141;8739.825203495926;8768.167024132697;8782.12178782123;8787.824243515157;8797;8596.742097737078;8656;8721.08428614999;8748.300135989106;8767.693130740394;41848.581514185076;42349;42389.57610423887;42410.15179696389;42413;3344.2976974835315;3400.795952242873;3483.0421634050585;3571.8392672329805;3843.3466310726963;30728.53907191394;30847.691523084708;30881.38237235265;31018;31033.534496982338;3527.1358517163458;3581.301646178996;3589.2821435712963;3694.7783133012103;3719.274741425423;276086;277443;277779;278222;278897;61701.69149154225;62090.0686489703;62157;62265.68867155635;62293.68853155796;64049.67975160188;68617;69880.3011969884;69917.65041174863;69932.65033674799;14747.262636868114;14793.408263669333;14831.332590033475;14843.554693359216;14843.703125937422;11952.04383649306;12008.879911200776;12021.879781202077;12033.939830300968;12036.097292703082;20249.898750506152;20576.691349629768;20698.793012069687;20705.790602456644;20711.171553137705;8005.719799806979;8193.297208915126;8299.29455996247;8363.749087527262;8457.619407126695;917.866909298148;951.8810148731409;993.5926270229171;1012.5392946209457;1031.3554028732042;28555.428891422056;28753.28116797055;29104.563431548544;29149.417011659647;29187.270318242216;1104.6851647280487;1113.9108871290277;1151.740858306891;1190.1014733875868;1200.7418405042959;14682.55952321432;15071.54785356441;15134.470293539893;15138.243087845563;15224.543263702106;307430;310941;311597;311814;312516;53244.73377633165;54219.64450888759;54234.72882635562;54353;54541.181882271005;1197.2098415046028;1337.2444568818587;1343.7849944008913;1354.1536539662711;1365.3173413293352;25248.74751252464;28238.43523129567;28486.85756571204;28726.138215853556;28944;41732.374014390414;41776.79111604422;42157.78921105375;42248.78875605603;42901.356479653456;187793;190083;198117;199250;199299;27375.726242737317;31658.67583903657;32164.517532237503;32329.030129096165;32433;38444.807775960944;38548.6145138545;38716;39182.80408597939;39392.60607393889;32884.50673239951;32982.670173297956;33130.5030424539;33158;33379.33241335111;32754.67245327516;33031.83484082564;33257.334853302316;33357.49963750594;33572.1606959828;34947.12632184216;35933.64066359407;35954.64045359618;36029.81985090163;36220.27559448849;33760.324793504486;36947.630523695494;37962.810185948896;39437;40280.1943961125;25374.492510150063;25386.492270154125;25727.485450290515;25847.353816154748;26170.476590467704 17:31:29 INFO - PROCESS | 31610 | |2;jquery.html;339.6722163112596;343.3579206883129;343.54308769336785;357;357.1107941226346;16835.83164168358;17334.479965601036;17484.825151748464;18600.906995465037;18751.437456876316;17243.74134387982;17710;17834.821651783477;17843.10784460778;17848.37530686426;5270.868228294285;5349.598780091499;5448.264484294609;5453.509184173424;5460.945390546103;4020.4170395292663;4192.937105943413;5407.918881216785;5438.945610543903;5817.447342502476;6016.368281330463;6018.277806663206;6021.337652858182;6047.697615119248;6050.757969681207;5828.475437210672;5895.410458954113;5998.760049597989;6002.159697642312;6038.547108966845;3583.122135076897;3739.439084137374;3740.214554943438;5251.291075704808;5270.525652691276;16559.751603725952;18976.81023189764;19804.80195198044;19950.700739488773;21499.67750483744;2059.4954236212225;2111.883846388448;2137.7434707835005;2183.6287831068757;2202.053117159621;12017.579384721494;13209;13255;13616.795748063787;13691.931540342333;1902.4863286912594;1912.6557219700449;1946.4160751774411;1946.4549926020736;1968.940931772035;62457;63284;64606;64775.67612161956;64777.352226477604;9425;9584.90415095854;9648.324617276723;9670;9740.659076932274;12345.197562158432;12433.254004759563;12441.377931103409;12448.937755311166;12531.18547294423;7205.92794072063;7315.743948961761;7368.4842061055215;7442;7447.962760186165;7207.243239459886;7236;7257.129144502588;7306.269373062758;7307.744228951961;5979;6026.578139530278;6054.122152287893;6063.818085457355;6078.969605151946;1560.5084398414463;1617.967640647204;1687.1564217891055;1691.3065643086522;1742.3901634427848;983.341161421849;1001.2940876681922;1011.22135955314;1031.8916513765946;1041.4740556019162;16626.75059874103;16971.575710607332;17197.1401429928;17526.474205773848;17696.734548981774;962.8363178259713;973.4062222044547;1028.5937054863437;1038.5793753529833;1076.6070384309671;8898.59956301968;10256.230782691327;10309;10318.535665895053;10329.276950613385;436739;438985;445880;447219.81950450846;451742;68033.3196668027;70389.29610703827;70543;71516.28483715201;72535;1008.6520150548049;1035.052926572178;1039.9844002339971;1042.5308611125024;1069.4813015687384;12823.61529154127;15109.39562417491;15157.317920693375;15510.767338489706;15573.987690800062;30631.846840765655;31129.844350779007;31159.84420077885;31453.528197076605;31645.208869777518;40250;40418;40595.188096238504;40873.38689919594;41061.38407923824;7506.512076714996;7801.921980780119;7852.293293603603;7880.763577092696;7947.3244774194845;11661.941690291495;12834.614961551168;12887.226766394046;12893.935530322664;12900.870991290343;10924.2899211551;11133.165012624248;11184.328940263611;11307.378094204898;11493.195476316578;8609.569521524025;10812.243142979916;11077;11077.667669969915;11094.11247100214;11230.157738169506;11329.546818127183;11538.307701537935;11586.88413115858;11631.418429078682;7677.155512893689;7723.035952063906;7871;8004.1595632460085;8061.153578874134;8994.415363001384;11143.944280278547;11343.886561134283;11345.773084538429;11353.148513861659 17:31:29 INFO - PROCESS | 31610 | |3;mootools.html;1321.6629759411348;1481.570344600066;1522.3834347089426;1688.5862963573918;1850.3986204483547;7487.550746955187;7682.270184332479;7684.269994350535;7692.769216923487;7698.230176982299;7627.19914408986;7710.961445192766;7738.690452381912;7789.454738168331;7795.649195786189;1971.053894130818;2260.5930932432116;2269.069681430614;2283.5775381554467;2337.7895989360954;2290.393045842853;2297.7127859017623;2306.2965795432387;2306.3888069661552;2308.826837987158;2251.898664560099;2317.9304620861403;2323.465602911331;2323.93028209154;2324.895379707909;2254.7519772824976;2286.131270117353;2305.6426253930667;2310.653401989698;2313.0400883633274;2271.46620544172;2285.897134628929;2291.255342013852;2292.1748170658548;2325.918592849259;7730.845383092306;7806.1413244543055;7809.3752499799875;7811.4922530035365;7824.295813376823;4776.307435421844;4935.925961110586;4952.727599981999;4963.553280204799;4963.8262660806695;3087.938241235185;3153.495440729472;3162.067190178903;3174.1429813950103;3226.4837625979967;971.504532688327;999.115782532464;999.4652860719481;1011.7824667696481;1031.8658574385356;11028.503717332658;11039.39283339416;11044.944775276153;11048.116150708005;11064.28082174664;4364.388985542027;4487.439070116236;4499.370088187657;4538.455385353713;4552.362669226311;9312.580933857993;9372.062793720574;9378.249740020918;9391.34260601765;9398.577064032135;4328.61042506176;4863.829765958175;4879.414470263591;4892.315075889378;4912.238603016538;4342.848000319974;4409.36064270679;4428.3800267962515;4469.754163520973;4476.619487343547;3715.64701353371;3764.4541541476333;3774.75464094833;3804.0680033391995;3821.961780382216;1156.976860462803;1183.355071486042;1191.7259030422879;1194.4445832687843;1196.21050106929;1038.2628333883029;1045.3571053801857;1056.8837427882927;1215.1858254969193;1376.4012654495327;7134.857302854018;7530;7536.924630753732;7540.924590754132;7546.509476883985;1127.4081107418672;1128.1707944660668;1128.6614015795228;1141.851559297286;1155.2721785275223;5660.660360378308;5661;5695.145728140729;5702.287214098238;5702.45826646468;9109.863352049724;9636.373635713657;9724.61101555944;9826.459544724965;9827.459489728133;9657.90342096584;9663.565139568596;9666.903330966741;9678.225741940629;9700.805983880424;7177.138743350832;7364.668589913466;7417.777466676009;7429.517081389692;7432.702691892372;7293.343599076109;7343.669534870837;7417.554946703215;7426.962865185639;7434.553926764412;8124.187581242065;8425.2838508725;8537.87193192115;8543.359248056297;8639.827203456021;8416.148447341575;8476.152384761475;8560.57197140153;8588.957055214683;8595.742127736177;5940.198073260054;6484.546081774419;6702.765403210864;6777.423918966943;6886.965565172142;7666.386689064973;7699.846003080019;7700.152983171959;7706.113796913427;7736.613169341398;6701.1623547056615;6807.795766127024;6818.659067046528;6978.371946524634;6988.650567471708;6857.965710171417;6890.173179218526;6908.3437073477935;7023.964880175567;7049.612271325126;7133.072700548895;7171.103612048494;7200.531965422231;7218.27817218274;7250.9637451812405;6264.874702505833;6357.427831495188;6369.108324834619;6475.158229430144;6486.254080780582;6267.1539342188225;6325.588836725598;6371.55399122057;6376.808695739135;6379.553431259767 17:31:29 INFO - PROCESS | 31610 | |4;prototype.html;321.89377505423215;323.34683938444346;328.924347400098;330.65776920886884;334.81585128179495;5862.88274234515;5866.941330586693;5868.178455016296;5877.089051197061;5922.437368449991;5790.739416726247;5797.884042319151;5802.883942321151;5812.593118481697;5827.271591051119;4293.484781826185;4404.625606823424;4466.397036400077;4476.350929115276;4488.8204471821255;4442.844500442469;4465.575770301833;4479.059397526524;4480.686351955364;4496.348029535716;4289.378040184171;4445.110977804436;4476.977615111936;4483.170613436525;4492.573205545468;4374.059577190903;4462.57605527476;4497.437820272466;4498.550144985508;4504.909901801946;3907.3943538751255;3924.823382947774;3958.7228893977435;3960.6929713194577;3976.76139431635;5495.477929596682;5498.367687715924;5499.917501237484;5503.064479038533;5513.972430137824;5192.740362981874;5216.8695782605355;5223.294855194538;5237.266782650432;5246.0032593807055;6109.114178444145;6114.663693496856;6141.170941922873;6142.938570614326;6145.846353841145;4273.081287523167;4395.296752519614;4406.977965110186;4408.911821763579;4418.270985287424;6394.584352017104;6442.613443193423;6464.515161362917;6466.191726034199;6472.514561407913;4406.735595864258;4430.246858034142;4431.800568974404;4432.091421258634;4432.49026361966;4481.574250446202;4485.25993211123;4485.641148708096;4487.2147374210035;4489.124620698933;5182.274481572583;5183.403908550565;5184.118699820964;5192.792288308426;5193.714345710947;6053.545984051214;6247.468965137923;6254.843628909313;6260.655663938436;6272.874542509125;1599.41621308224;1600.0799540264395;1603.262499250358;1605.8635016023536;1606.092557704893;1017.725214192164;1061.840723891407;1084.1326938449208;1117.8379135025539;1127.7293449572044;5822.126680997884;5917.615355001911;5925.525957923356;5935.6735379553675;5937.228160339128;6245.437910587978;6284.183056202664;6286.591371560834;6286.9056964145575;6289.40250676185;5864.472197502245;5873.471387575139;5873.58884878063;5874.265716785402;5876.206712093898;3314.668533146666;3385.4921761735445;3385.610654774683;3387.7289816815087;3393.898183054512;6595.70319335631;6633.9668301658185;6639.136912201479;6854.246032936373;6857.759978400732;6574.3754343337305;6615.17310336208;6616.4376028037195;6617.205935287796;6620.536562440583;6813.216480104752;6814.931850681529;6816.522843400914;6828.5902845829405;6832.6925288362145;6413;6421.903671445026;6423.325550817097;6428.967855160694;6430.035494675836;6235.501159907106;6371.96814015927;6388.169537960035;6406.647634379968;6434.131392261985;6841.657917104224;6858.554193977376;6859.5541289816;6867.175938887365;6872.10662613877;4293.592108749664;4317.114991426813;4317.481902171634;4323.610875021137;4325.653947684114;6451.096846441408;6453.290138084901;6453.548251622341;6458.38645328693;6461.741530338733;6179.412955769195;6238.376162383725;6254.749810007549;6260.937390626218;6265.780697675559;6038.396160383926;6243.313235544178;6255.874882502233;6268.686565671789;6279.905801413074;6124.418180272867;6134.355892631388;6162.969185154046;6164.291106522628;6164.753409863734;6301.149344838388;6301.7164227608955;6301.747930082929;6307.463865571478;6311.211098612674;5888.617239879394;5953.970230148821;6160.291566469913;6161.845953851011;6167.444929956326 17:31:29 INFO - PROCESS | 31610 | |5;yui.html;750.8836130399789;817.4523069543405;819.7581713394547;824.0770337222311;855.5722138930532;13711.65720856979;13948.930255348734;13956.232407217625;13982.650433739149;14018.929905350471;12790.936045319784;12819.807702884464;12835;12842.93578532106;12862.614121576344;682.4131247127491;817.2971244729528;831.6382373667474;835.1523203947997;839.2279103225017;824.3199360527589;826.2274773087153;826.7519744076753;827.2430725885837;828.2835347424465;867.1371984875058;870.1689886158704;870.2733217763175;870.4777133719749;870.78665726897;707.073733409233;860.7417774667606;864.8745931839911;880.2385936165235;881.0704706534603;645.2934037229227;648.8345471904681;651.1990251990031;651.540663832002;652.3900153356627;13842.031057825956;13856.030077894551;13906.30468476572;13922.303884805719;13942.790858137034;12820.23078615286;13079.673008174872;13202;13250.46998120074;13399.933000335033;10556.788864222672;10563.313384630052;10677.1992100592;10798.082163016154;10829.783404331869;3597.9820100899587;3653.1780349421433;3655.8354874030733;3664.8534058637624;3714.5542534895717;48350.516494834956;48599.514004859855;48843.755781221225;48856.602905738655;48861.51138488605;10280.331778434378;10505.264631475877;10678;10743.570257189782;10819.242653014371;19129.617407651767;19131.2347506101;19143.712844307345;19150.904245478683;19215.231390744215;7930.246626570467;8009.639566219417;8093.312068474245;8216;8409.159084091541;4600.171969045604;4663.230566956482;4667.113248482778;4745.288206768943;4847.297141914402;3226.2418331692033;3234.256121092115;3237.2554312508255;3243.0433022258017;3248.6101667799544;576.3400905962733;578.9400638420177;582.3215953414225;587.7149582452507;592.0881841963328;586.352080950552;696.8466937273791;697.9232284448707;722.8265216348144;726.6076318787901;8329.125441828643;8462.36532260083;8591.3556483264;8663.220310172115;8726.258268047288;660.3495556876472;683.54885775389;697.7883573270308;710.4777988178685;717.0427479315068;3887.475190849256;4018.678505719535;4091.365838295069;4133.627973482401;4153.854615088518;56553;57831;58046;58057.4194258052;58303.708481457325;52323.73838130785;52438.47561524412;52476.999999999236;52593;52947.73526132345;44470.33294500585;45488.77255613701;45970.31044534335;46077.7696111524;46374;7866;7956.84086318282;7967.083785364757;8048.5170889746805;8139.674413023413;33907.66092339045;34159.4876076864;34702.479462807576;35579;35635.82182089073;41158;41447;42470.150596988504;43815.34276985784;44040.339394909744;10080.445575493419;10370.948145259226;10470.947645261725;10903.29128606638;11488.209208424792;12440.875591244334;12511.249325040526;12711;12802.551910683082;12802.615921522369;11451.312921224753;11457.713557161138;11769.891780788063;11882.049436045269;12191.085668574715;11965.341906195243;12265.938670306592;12390.442430090849;12399;12748.553800616934;10944.835827462754;10975.28660637056;11064.533152774507;11073.612423565137;11513.53945842157;10085.394876307446;10289.2797504174;10294;10410.567440373321;10608.628697995842;9241.111443083304;9332.837116983004;9563.521823908915;9600;10198.796024079626 17:31:29 INFO - PROCESS | 31610 | __end_tp_report 17:31:29 INFO - PROCESS | 31610 | __start_cc_report 17:31:29 INFO - PROCESS | 31610 | _x_x_mozilla_cycle_collect,1129 17:31:29 INFO - PROCESS | 31610 | __end_cc_report 17:31:29 INFO - PROCESS | 31610 | __startTimestamp1456450289093__endTimestamp 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | ------- Summary: start ------- 17:31:29 INFO - PROCESS | 31610 | Number of tests: 6 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | [#0] dojo.html Cycles:165 Average:5056.52 Median:5253.66 stddev:536.37 (10.2%) stddev-sans-first:515.60 17:31:29 INFO - PROCESS | 31610 | Values: 3100.8 3125.2 3156.0 3166.5 3197.7 4934.0 5000.4 5041.6 5055.0 5075.3 4955.6 4969.5 4990.1 5001.3 5152.7 4520.8 4555.2 4586.8 4597.2 4715.9 4576.0 4587.4 4641.4 4650.9 4702.5 4622.4 4655.3 4657.1 4668.8 4690.9 4656.4 4665.8 4671.5 4691.0 4714.6 4507.9 4605.5 4642.9 4724.7 4736.5 4839.8 4873.3 4887.0 4888.3 4922.4 5356.3 5361.2 5377.4 5384.8 5399.0 5272.8 5442.1 5512.7 5559.6 5587.1 5088.1 5111.9 5116.5 5117.2 5117.7 5292.3 5528.3 5535.7 5536.3 5541.0 5282.0 5337.6 5359.6 5397.6 5413.7 5351.3 5357.4 5358.8 5361.0 5365.4 5278.6 5328.7 5333.1 5392.2 5416.0 5438.8 5452.6 5471.3 5476.2 5515.3 4288.3 4310.4 4315.4 4315.8 4350.2 3753.2 3793.3 3850.3 3883.5 3892.2 5067.9 5072.4 5109.7 5134.4 5161.6 5394.3 5410.5 5410.8 5415.5 5452.4 4988.6 5030.9 5058.5 5096.4 5168.0 4682.6 4697.0 4702.4 4702.5 4740.6 5726.5 5748.6 5751.1 5755.5 5772.5 5217.6 5359.3 5442.5 5448.6 5455.4 5729.2 5737.9 5745.3 5746.0 5796.7 5371.7 5391.0 5397.2 5398.4 5399.9 5359.1 5441.1 5473.3 5475.9 5534.2 5200.6 5244.2 5250.6 5253.7 5272.2 5264.4 5273.9 5277.4 5306.3 5397.4 5225.4 5274.0 5276.9 5277.2 5315.9 5340.7 5351.1 5365.1 5365.2 5417.5 5111.9 5174.1 5265.4 5272.1 5325.0 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | [#1] ext.html Cycles:180 Average:43872.41 Median:3585.29 stddev:69458.84 (1937.3%) stddev-sans-first:69577.35 17:31:29 INFO - PROCESS | 31610 | Values: 501.4 502.2 512.4 518.2 541.4 29220.4 37502.1 38150.8 38207.0 38314.2 41565.6 41924.8 41980.4 42049.6 42068.8 8478.6 8673.7 8688.7 8691.7 8700.3 8443.9 8557.3 8572.6 8583.1 8586.7 8548.9 8816.5 8824.2 8832.6 8833.5 8739.8 8768.2 8782.1 8787.8 8797.0 8596.7 8656.0 8721.1 8748.3 8767.7 41848.6 42349.0 42389.6 42410.2 42413.0 3344.3 3400.8 3483.0 3571.8 3843.3 30728.5 30847.7 30881.4 31018.0 31033.5 3527.1 3581.3 3589.3 3694.8 3719.3 276086.0 277443.0 277779.0 278222.0 278897.0 61701.7 62090.1 62157.0 62265.7 62293.7 64049.7 68617.0 69880.3 69917.7 69932.7 14747.3 14793.4 14831.3 14843.6 14843.7 11952.0 12008.9 12021.9 12033.9 12036.1 20249.9 20576.7 20698.8 20705.8 20711.2 8005.7 8193.3 8299.3 8363.7 8457.6 917.9 951.9 993.6 1012.5 1031.4 28555.4 28753.3 29104.6 29149.4 29187.3 1104.7 1113.9 1151.7 1190.1 1200.7 14682.6 15071.5 15134.5 15138.2 15224.5 307430.0 310941.0 311597.0 311814.0 312516.0 53244.7 54219.6 54234.7 54353.0 54541.2 1197.2 1337.2 1343.8 1354.2 1365.3 25248.7 28238.4 28486.9 28726.1 28944.0 41732.4 41776.8 42157.8 42248.8 42901.4 187793.0 190083.0 198117.0 199250.0 199299.0 27375.7 31658.7 32164.5 32329.0 32433.0 38444.8 38548.6 38716.0 39182.8 39392.6 32884.5 32982.7 33130.5 33158.0 33379.3 32754.7 33031.8 33257.3 33357.5 33572.2 34947.1 35933.6 35954.6 36029.8 36220.3 33760.3 36947.6 37962.8 39437.0 40280.2 25374.5 25386.5 25727.5 25847.4 26170.5 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | [#2] jquery.html Cycles:180 Average:25319.31 Median:31144.84 stddev:72661.90 (233.3%) stddev-sans-first:72841.52 17:31:29 INFO - PROCESS | 31610 | Values: 339.7 343.4 343.5 357.0 357.1 16835.8 17334.5 17484.8 18600.9 18751.4 17243.7 17710.0 17834.8 17843.1 17848.4 5270.9 5349.6 5448.3 5453.5 5460.9 4020.4 4192.9 5407.9 5438.9 5817.4 6016.4 6018.3 6021.3 6047.7 6050.8 5828.5 5895.4 5998.8 6002.2 6038.5 3583.1 3739.4 3740.2 5251.3 5270.5 16559.8 18976.8 19804.8 19950.7 21499.7 2059.5 2111.9 2137.7 2183.6 2202.1 12017.6 13209.0 13255.0 13616.8 13691.9 1902.5 1912.7 1946.4 1946.5 1968.9 62457.0 63284.0 64606.0 64775.7 64777.4 9425.0 9584.9 9648.3 9670.0 9740.7 12345.2 12433.3 12441.4 12448.9 12531.2 7205.9 7315.7 7368.5 7442.0 7448.0 7207.2 7236.0 7257.1 7306.3 7307.7 5979.0 6026.6 6054.1 6063.8 6079.0 1560.5 1618.0 1687.2 1691.3 1742.4 983.3 1001.3 1011.2 1031.9 1041.5 16626.8 16971.6 17197.1 17526.5 17696.7 962.8 973.4 1028.6 1038.6 1076.6 8898.6 10256.2 10309.0 10318.5 10329.3 436739.0 438985.0 445880.0 447219.8 451742.0 68033.3 70389.3 70543.0 71516.3 72535.0 1008.7 1035.1 1040.0 1042.5 1069.5 12823.6 15109.4 15157.3 15510.8 15574.0 30631.8 31129.8 31159.8 31453.5 31645.2 40250.0 40418.0 40595.2 40873.4 41061.4 7506.5 7801.9 7852.3 7880.8 7947.3 11661.9 12834.6 12887.2 12893.9 12900.9 10924.3 11133.2 11184.3 11307.4 11493.2 8609.6 10812.2 11077.0 11077.7 11094.1 11230.2 11329.5 11538.3 11586.9 11631.4 7677.2 7723.0 7871.0 8004.2 8061.2 8994.4 11143.9 11343.9 11345.8 11353.1 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | [#3] mootools.html Cycles:180 Average:5521.32 Median:6341.51 stddev:2865.60 (45.2%) stddev-sans-first:2856.25 17:31:29 INFO - PROCESS | 31610 | Values: 1321.7 1481.6 1522.4 1688.6 1850.4 7487.6 7682.3 7684.3 7692.8 7698.2 7627.2 7711.0 7738.7 7789.5 7795.6 1971.1 2260.6 2269.1 2283.6 2337.8 2290.4 2297.7 2306.3 2306.4 2308.8 2251.9 2317.9 2323.5 2323.9 2324.9 2254.8 2286.1 2305.6 2310.7 2313.0 2271.5 2285.9 2291.3 2292.2 2325.9 7730.8 7806.1 7809.4 7811.5 7824.3 4776.3 4935.9 4952.7 4963.6 4963.8 3087.9 3153.5 3162.1 3174.1 3226.5 971.5 999.1 999.5 1011.8 1031.9 11028.5 11039.4 11044.9 11048.1 11064.3 4364.4 4487.4 4499.4 4538.5 4552.4 9312.6 9372.1 9378.2 9391.3 9398.6 4328.6 4863.8 4879.4 4892.3 4912.2 4342.8 4409.4 4428.4 4469.8 4476.6 3715.6 3764.5 3774.8 3804.1 3822.0 1157.0 1183.4 1191.7 1194.4 1196.2 1038.3 1045.4 1056.9 1215.2 1376.4 7134.9 7530.0 7536.9 7540.9 7546.5 1127.4 1128.2 1128.7 1141.9 1155.3 5660.7 5661.0 5695.1 5702.3 5702.5 9109.9 9636.4 9724.6 9826.5 9827.5 9657.9 9663.6 9666.9 9678.2 9700.8 7177.1 7364.7 7417.8 7429.5 7432.7 7293.3 7343.7 7417.6 7427.0 7434.6 8124.2 8425.3 8537.9 8543.4 8639.8 8416.1 8476.2 8560.6 8589.0 8595.7 5940.2 6484.5 6702.8 6777.4 6887.0 7666.4 7699.8 7700.2 7706.1 7736.6 6701.2 6807.8 6818.7 6978.4 6988.7 6858.0 6890.2 6908.3 7024.0 7049.6 7133.1 7171.1 7200.5 7218.3 7251.0 6264.9 6357.4 6369.1 6475.2 6486.3 6267.2 6325.6 6371.6 6376.8 6379.6 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | [#4] prototype.html Cycles:180 Average:5206.34 Median:5873.53 stddev:1576.84 (26.8%) stddev-sans-first:1538.06 17:31:29 INFO - PROCESS | 31610 | Values: 321.9 323.3 328.9 330.7 334.8 5862.9 5866.9 5868.2 5877.1 5922.4 5790.7 5797.9 5802.9 5812.6 5827.3 4293.5 4404.6 4466.4 4476.4 4488.8 4442.8 4465.6 4479.1 4480.7 4496.3 4289.4 4445.1 4477.0 4483.2 4492.6 4374.1 4462.6 4497.4 4498.6 4504.9 3907.4 3924.8 3958.7 3960.7 3976.8 5495.5 5498.4 5499.9 5503.1 5514.0 5192.7 5216.9 5223.3 5237.3 5246.0 6109.1 6114.7 6141.2 6142.9 6145.8 4273.1 4395.3 4407.0 4408.9 4418.3 6394.6 6442.6 6464.5 6466.2 6472.5 4406.7 4430.2 4431.8 4432.1 4432.5 4481.6 4485.3 4485.6 4487.2 4489.1 5182.3 5183.4 5184.1 5192.8 5193.7 6053.5 6247.5 6254.8 6260.7 6272.9 1599.4 1600.1 1603.3 1605.9 1606.1 1017.7 1061.8 1084.1 1117.8 1127.7 5822.1 5917.6 5925.5 5935.7 5937.2 6245.4 6284.2 6286.6 6286.9 6289.4 5864.5 5873.5 5873.6 5874.3 5876.2 3314.7 3385.5 3385.6 3387.7 3393.9 6595.7 6634.0 6639.1 6854.2 6857.8 6574.4 6615.2 6616.4 6617.2 6620.5 6813.2 6814.9 6816.5 6828.6 6832.7 6413.0 6421.9 6423.3 6429.0 6430.0 6235.5 6372.0 6388.2 6406.6 6434.1 6841.7 6858.6 6859.6 6867.2 6872.1 4293.6 4317.1 4317.5 4323.6 4325.7 6451.1 6453.3 6453.5 6458.4 6461.7 6179.4 6238.4 6254.7 6260.9 6265.8 6038.4 6243.3 6255.9 6268.7 6279.9 6124.4 6134.4 6163.0 6164.3 6164.8 6301.1 6301.7 6301.7 6307.5 6311.2 5888.6 5954.0 6160.3 6161.8 6167.4 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - PROCESS | 31610 | [#5] yui.html Cycles:180 Average:13941.12 Median:44255.34 stddev:15911.11 (36.0%) stddev-sans-first:15924.91 17:31:29 INFO - PROCESS | 31610 | Values: 750.9 817.5 819.8 824.1 855.6 13711.7 13948.9 13956.2 13982.7 14018.9 12790.9 12819.8 12835.0 12842.9 12862.6 682.4 817.3 831.6 835.2 839.2 824.3 826.2 826.8 827.2 828.3 867.1 870.2 870.3 870.5 870.8 707.1 860.7 864.9 880.2 881.1 645.3 648.8 651.2 651.5 652.4 13842.0 13856.0 13906.3 13922.3 13942.8 12820.2 13079.7 13202.0 13250.5 13399.9 10556.8 10563.3 10677.2 10798.1 10829.8 3598.0 3653.2 3655.8 3664.9 3714.6 48350.5 48599.5 48843.8 48856.6 48861.5 10280.3 10505.3 10678.0 10743.6 10819.2 19129.6 19131.2 19143.7 19150.9 19215.2 7930.2 8009.6 8093.3 8216.0 8409.2 4600.2 4663.2 4667.1 4745.3 4847.3 3226.2 3234.3 3237.3 3243.0 3248.6 576.3 578.9 582.3 587.7 592.1 586.4 696.8 697.9 722.8 726.6 8329.1 8462.4 8591.4 8663.2 8726.3 660.3 683.5 697.8 710.5 717.0 3887.5 4018.7 4091.4 4133.6 4153.9 56553.0 57831.0 58046.0 58057.4 58303.7 52323.7 52438.5 52477.0 52593.0 52947.7 44470.3 45488.8 45970.3 46077.8 46374.0 7866.0 7956.8 7967.1 8048.5 8139.7 33907.7 34159.5 34702.5 35579.0 35635.8 41158.0 41447.0 42470.2 43815.3 44040.3 10080.4 10370.9 10470.9 10903.3 11488.2 12440.9 12511.2 12711.0 12802.6 12802.6 11451.3 11457.7 11769.9 11882.0 12191.1 11965.3 12265.9 12390.4 12399.0 12748.6 10944.8 10975.3 11064.5 11073.6 11513.5 10085.4 10289.3 10294.0 10410.6 10608.6 9241.1 9332.8 9563.5 9600.0 10198.8 17:31:29 INFO - PROCESS | 31610 | -------- Summary: end -------- 17:31:29 INFO - PROCESS | 31610 | 17:31:29 INFO - TEST-INFO | 31610: exit 0 17:31:29 INFO - TEST-OK | dromaeo_css | took 1113161ms 17:31:29 INFO - TEST-START | kraken 17:31:29 INFO - operating with platform_type : linux_ 17:31:29 INFO - Initialising browser for kraken test... 17:31:29 INFO - TEST-INFO | started process 31801 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXauoW0/profile http://localhost:45876/getInfo.html) 17:31:33 INFO - PROCESS | 31801 | __metrics Screen width/height:1600/1200 17:31:33 INFO - PROCESS | 31801 | colorDepth:24 17:31:33 INFO - PROCESS | 31801 | Browser inner width/height: 1024/697 17:31:33 INFO - PROCESS | 31801 | __metrics 17:31:34 INFO - PROCESS | 31801 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:31:35 INFO - PROCESS | 31801 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:31:35 INFO - TEST-INFO | 31801: exit 0 17:31:35 INFO - Browser initialized. 17:31:35 INFO - Running cycle 1/1 for kraken test... 17:31:35 INFO - TEST-INFO | started process 31887 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXauoW0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:47 INFO - PROCESS | 31887 | RSS: Main: 147259392 17:31:47 INFO - PROCESS | 31887 | 17:31:50 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45876/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:50 INFO - PROCESS | 31887 | RSS: Main: 192765952 17:31:50 INFO - PROCESS | 31887 | 17:31:53 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45876/tests/kraken/driver.html?testName=audio-dft) 17:31:54 INFO - PROCESS | 31887 | RSS: Main: 182808576 17:31:54 INFO - PROCESS | 31887 | 17:31:56 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45876/tests/kraken/driver.html?testName=audio-fft) 17:31:57 INFO - PROCESS | 31887 | RSS: Main: 166780928 17:31:57 INFO - PROCESS | 31887 | 17:31:59 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45876/tests/kraken/driver.html?testName=audio-oscillator) 17:32:00 INFO - PROCESS | 31887 | RSS: Main: 167903232 17:32:00 INFO - PROCESS | 31887 | 17:32:02 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:02 INFO - PROCESS | 31887 | RSS: Main: 170078208 17:32:02 INFO - PROCESS | 31887 | 17:32:05 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45876/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:06 INFO - PROCESS | 31887 | RSS: Main: 170180608 17:32:06 INFO - PROCESS | 31887 | 17:32:09 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45876/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:10 INFO - PROCESS | 31887 | RSS: Main: 170373120 17:32:10 INFO - PROCESS | 31887 | 17:32:13 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45876/tests/kraken/driver.html?testName=json-parse-financial) 17:32:13 INFO - PROCESS | 31887 | RSS: Main: 170029056 17:32:13 INFO - PROCESS | 31887 | 17:32:15 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:15 INFO - PROCESS | 31887 | RSS: Main: 180563968 17:32:15 INFO - PROCESS | 31887 | 17:32:17 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:18 INFO - PROCESS | 31887 | RSS: Main: 179122176 17:32:18 INFO - PROCESS | 31887 | 17:32:20 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:21 INFO - PROCESS | 31887 | RSS: Main: 192585728 17:32:21 INFO - PROCESS | 31887 | 17:32:23 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:24 INFO - PROCESS | 31887 | RSS: Main: 194752512 17:32:24 INFO - PROCESS | 31887 | 17:32:26 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:27 INFO - PROCESS | 31887 | RSS: Main: 197038080 17:32:27 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | Cycle 1(1): loaded http://localhost:45876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45876/tests/kraken/driver.html?testName=ai-astar) 17:32:29 INFO - PROCESS | 31887 | RSS: Main: 257490944 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | __start_tp_report 17:32:29 INFO - PROCESS | 31887 | _x_x_mozilla_page_load 17:32:29 INFO - PROCESS | 31887 | _x_x_mozilla_page_load_details 17:32:29 INFO - PROCESS | 31887 | |i|pagename|runs| 17:32:29 INFO - PROCESS | 31887 | |0;ai-astar;109;112;107;110;112;110;101;111;110;111 17:32:29 INFO - PROCESS | 31887 | |1;audio-beat-detection;154;134;158;162;133;149;152;127;171;134 17:32:29 INFO - PROCESS | 31887 | |2;audio-dft;163;162;162;161;161;159;162;166;164;161 17:32:29 INFO - PROCESS | 31887 | |3;audio-fft;74;75;117;93;74;76;73;108;96;73 17:32:29 INFO - PROCESS | 31887 | |4;audio-oscillator;96;97;140;95;96;96;145;96;96;152 17:32:29 INFO - PROCESS | 31887 | |5;imaging-gaussian-blur;120;116;116;115;116;115;115;115;115;115 17:32:29 INFO - PROCESS | 31887 | |6;imaging-darkroom;145;146;145;144;145;145;145;146;144;145 17:32:29 INFO - PROCESS | 31887 | |7;imaging-desaturate;95;96;96;95;96;96;96;97;97;96 17:32:29 INFO - PROCESS | 31887 | |8;json-parse-financial;55;56;55;57;56;56;59;65;54;53 17:32:29 INFO - PROCESS | 31887 | |9;json-stringify-tinderbox;68;67;67;68;68;68;67;68;68;68 17:32:29 INFO - PROCESS | 31887 | |10;stanford-crypto-aes;84;82;85;91;85;85;85;84;84;92 17:32:29 INFO - PROCESS | 31887 | |11;stanford-crypto-ccm;118;116;117;116;119;133;129;133;119;118 17:32:29 INFO - PROCESS | 31887 | |12;stanford-crypto-pbkdf2;160;139;148;154;152;140;149;156;158;153 17:32:29 INFO - PROCESS | 31887 | |13;stanford-crypto-sha256-iterative;69;73;72;69;70;71;70;69;70;69 17:32:29 INFO - PROCESS | 31887 | __end_tp_report 17:32:29 INFO - PROCESS | 31887 | __start_cc_report 17:32:29 INFO - PROCESS | 31887 | _x_x_mozilla_cycle_collect,1069 17:32:29 INFO - PROCESS | 31887 | __end_cc_report 17:32:29 INFO - PROCESS | 31887 | __startTimestamp1456450349253__endTimestamp 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | ------- Summary: start ------- 17:32:29 INFO - PROCESS | 31887 | Number of tests: 14 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:3.27 (3.0%) stddev-sans-first:3.46 17:32:29 INFO - PROCESS | 31887 | Values: 109.0 112.0 107.0 110.0 112.0 110.0 101.0 111.0 110.0 111.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:153.00 stddev:14.65 (9.6%) stddev-sans-first:15.35 17:32:29 INFO - PROCESS | 31887 | Values: 154.0 134.0 158.0 162.0 133.0 149.0 152.0 127.0 171.0 134.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.91 (1.2%) stddev-sans-first:2.00 17:32:29 INFO - PROCESS | 31887 | Values: 163.0 162.0 162.0 161.0 161.0 159.0 162.0 166.0 164.0 161.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#3] audio-fft Cycles:10 Average:85.90 Median:74.50 stddev:16.47 (22.1%) stddev-sans-first:16.90 17:32:29 INFO - PROCESS | 31887 | Values: 74.0 75.0 117.0 93.0 74.0 76.0 73.0 108.0 96.0 73.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.00 stddev:24.16 (25.2%) stddev-sans-first:25.02 17:32:29 INFO - PROCESS | 31887 | Values: 96.0 97.0 140.0 95.0 96.0 96.0 145.0 96.0 96.0 152.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:1.55 (1.3%) stddev-sans-first:0.50 17:32:29 INFO - PROCESS | 31887 | Values: 120.0 116.0 116.0 115.0 116.0 115.0 115.0 115.0 115.0 115.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:32:29 INFO - PROCESS | 31887 | Values: 145.0 146.0 145.0 144.0 145.0 145.0 145.0 146.0 144.0 145.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:32:29 INFO - PROCESS | 31887 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 97.0 96.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.37 (6.0%) stddev-sans-first:3.53 17:32:29 INFO - PROCESS | 31887 | Values: 55.0 56.0 55.0 57.0 56.0 56.0 59.0 65.0 54.0 53.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 17:32:29 INFO - PROCESS | 31887 | Values: 68.0 67.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 68.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:3.20 (3.8%) stddev-sans-first:3.33 17:32:29 INFO - PROCESS | 31887 | Values: 84.0 82.0 85.0 91.0 85.0 85.0 85.0 84.0 84.0 92.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:119.00 stddev:6.97 (5.9%) stddev-sans-first:7.26 17:32:29 INFO - PROCESS | 31887 | Values: 118.0 116.0 117.0 116.0 119.0 133.0 129.0 133.0 119.0 118.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:153.50 stddev:7.05 (4.6%) stddev-sans-first:6.66 17:32:29 INFO - PROCESS | 31887 | Values: 160.0 139.0 148.0 154.0 152.0 140.0 149.0 156.0 158.0 153.0 17:32:29 INFO - PROCESS | 31887 | 17:32:29 INFO - PROCESS | 31887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.40 (2.0%) stddev-sans-first:1.41 17:32:29 INFO - PROCESS | 31887 | Values: 69.0 73.0 72.0 69.0 70.0 71.0 70.0 69.0 70.0 69.0 17:32:29 INFO - PROCESS | 31887 | -------- Summary: end -------- 17:32:29 INFO - PROCESS | 31887 | 17:32:30 INFO - TEST-INFO | 31887: exit 0 17:32:30 INFO - TEST-OK | kraken | took 60370ms 17:32:30 INFO - SUITE-END | took 1173s 17:32:30 INFO - Completed test suite (00:19:33) 17:32:30 INFO - Working with test: dromaeo_css 17:32:30 INFO - Generating results file: dromaeo_css 17:32:30 INFO - Working with test: kraken 17:32:30 INFO - Generating results file: kraken 17:32:30 INFO - javascript benchmark 17:32:30 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:32:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:32:30 INFO - process_Request line: dromaeo_css 6887.67 graph.html#tests=[[72,64,35]] 17:32:30 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:32:30 INFO - process_Request line: kraken 1525.30 graph.html#tests=[[232,64,35]] 17:32:30 INFO - RETURN: dromaeo_css: 6887.67 17:32:30 INFO - RETURN: kraken: 1525.30 17:32:30 INFO - javascript benchmark 17:32:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3100.829454380009, 3125.2030732163294, 3155.9684403155975, 3166.461701510744, 3197.728193103587, 4934.0, 5000.424951130621, 5041.621878359119, 5055.014272216915, 5075.264086707425, 4955.554000139987, 4969.5030496950285, 4990.0518901408705, 5001.349824522816, 5152.716600586966, 4520.751358675271, 4555.20283950309, 4586.770661466921, 4597.195490789115, 4715.90568188636, 4576.0, 4587.403637527117, 4641.396618439599, 4650.883727906796, 4702.459217190016, 4622.375979242793, 4655.278431843053, 4657.091867085919, 4668.813247470097, 4690.859274221779, 4656.394668693082, 4665.813367465297, 4671.532846715335, 4691.038337140878, 4714.575688188045, 4507.932381014288, 4605.516420775803, 4642.86071417858, 4724.71651700899, 4736.5026672199265, 4839.758012099416, 4873.31773551703, 4886.951130488721, 4888.291197776338, 4922.384701912261, 5356.250124982505, 5361.222622719683, 5377.381601115882, 5384.7846086156505, 5398.973005134989, 5272.841814745525, 5442.074847275972, 5512.724363781835, 5559.555235581144, 5587.078132108238, 5088.109580823341, 5111.897762044776, 5116.488351164891, 5117.181250999822, 5117.692938423706, 5292.259083728281, 5528.253685752372, 5535.723213839292, 5536.335639723259, 5541.0, 5281.973590132025, 5337.572994160458, 5359.624826262202, 5397.649152805055, 5413.729313534308, 5351.277577527062, 5357.4106848246665, 5358.812645484778, 5360.973195133999, 5365.382980957162, 5278.604104692164, 5328.653637513549, 5333.120035194227, 5392.218128371364, 5415.972920135374, 5438.755256013489, 5452.6183167177915, 5471.343438787371, 5476.17857321405, 5515.338159420895, 4288.313869780883, 4310.439642846472, 4315.395844581761, 4315.762633055212, 4350.195213885441, 3753.1930634913624, 3793.2982398256413, 3850.306944749972, 3883.475730776309, 3892.2215556888737, 5067.87330316745, 5072.391313042459, 5109.6678715883345, 5134.383873935151, 5161.5870730341485, 5394.298741163623, 5410.540104091117, 5410.810621628224, 5415.539679127318, 5452.372977107604, 4988.625853061035, 5030.899382012412, 5058.519440653132, 5096.439391666913, 5168.04391187624, 4682.578567928835, 4697.0, 4702.435707715028, 4702.506236845151, 4740.620750340034, 5726.455986681259, 5748.5688573357165, 5751.1085781703905, 5755.539556835443, 5772.538196944234, 5217.582593392595, 5359.276497672764, 5442.510174084351, 5448.645838020675, 5455.427180146027, 5729.197912292366, 5737.885242295214, 5745.2818397700285, 5745.97127014379, 5796.681182535001, 5371.704556249444, 5390.97304513475, 5397.190421436816, 5398.433164517669, 5399.9460005401015, 5359.088954877602, 5441.075017247156, 5473.28847249855, 5475.863103422446, 5534.169874518693, 5200.60995425337, 5244.187150991603, 5250.553702935294, 5253.658512196695, 5272.209168624737, 5264.420913699567, 5273.947260527499, 5277.4194838566955, 5306.310179676618, 5397.379301380392, 5225.372955245395, 5274.0, 5276.894462110813, 5277.15565509532, 5315.893682126413, 5340.732963351895, 5351.143816989419, 5365.141577347606, 5365.248865158959, 5417.458254174551, 5111.923321150261, 5174.14626586609, 5265.447128051653, 5272.103742363884, 5324.9733751331], "unit": "score", "name": "dojo.html", "value": 5023.968199900444}, {"lowerIsBetter": false, "replicates": [501.3607650245936, 502.2466300549176, 512.3774613844181, 518.1916210711289, 541.3855274263709, 29220.415591688154, 37502.0624484388, 38150.809245953766, 38207.0, 38314.233715325674, 41565.58434415655, 41924.79037604816, 41980.37029444553, 42049.57950420495, 42068.789656051755, 8478.618462169217, 8673.696420625249, 8688.695895643654, 8691.739247822576, 8700.347473939448, 8443.873341899876, 8557.315414766836, 8572.571371431435, 8583.05586385497, 8586.656533738644, 8548.871766923501, 8816.515091669955, 8824.161704638049, 8832.558372081403, 8833.51415672141, 8739.825203495926, 8768.167024132697, 8782.12178782123, 8787.824243515157, 8797.0, 8596.742097737078, 8656.0, 8721.08428614999, 8748.300135989106, 8767.693130740394, 41848.581514185076, 42349.0, 42389.57610423887, 42410.15179696389, 42413.0, 3344.2976974835315, 3400.795952242873, 3483.0421634050585, 3571.8392672329805, 3843.3466310726963, 30728.53907191394, 30847.691523084708, 30881.38237235265, 31018.0, 31033.534496982338, 3527.1358517163458, 3581.301646178996, 3589.2821435712963, 3694.7783133012103, 3719.274741425423, 276086.0, 277443.0, 277779.0, 278222.0, 278897.0, 61701.69149154225, 62090.0686489703, 62157.0, 62265.68867155635, 62293.68853155796, 64049.67975160188, 68617.0, 69880.3011969884, 69917.65041174863, 69932.65033674799, 14747.262636868114, 14793.408263669333, 14831.332590033475, 14843.554693359216, 14843.703125937422, 11952.04383649306, 12008.879911200776, 12021.879781202077, 12033.939830300968, 12036.097292703082, 20249.898750506152, 20576.691349629768, 20698.793012069687, 20705.790602456644, 20711.171553137705, 8005.719799806979, 8193.297208915126, 8299.29455996247, 8363.749087527262, 8457.619407126695, 917.866909298148, 951.8810148731409, 993.5926270229171, 1012.5392946209457, 1031.3554028732042, 28555.428891422056, 28753.28116797055, 29104.563431548544, 29149.417011659647, 29187.270318242216, 1104.6851647280487, 1113.9108871290277, 1151.740858306891, 1190.1014733875868, 1200.7418405042959, 14682.55952321432, 15071.54785356441, 15134.470293539893, 15138.243087845563, 15224.543263702106, 307430.0, 310941.0, 311597.0, 311814.0, 312516.0, 53244.73377633165, 54219.64450888759, 54234.72882635562, 54353.0, 54541.181882271005, 1197.2098415046028, 1337.2444568818587, 1343.7849944008913, 1354.1536539662711, 1365.3173413293352, 25248.74751252464, 28238.43523129567, 28486.85756571204, 28726.138215853556, 28944.0, 41732.374014390414, 41776.79111604422, 42157.78921105375, 42248.78875605603, 42901.356479653456, 187793.0, 190083.0, 198117.0, 199250.0, 199299.0, 27375.726242737317, 31658.67583903657, 32164.517532237503, 32329.030129096165, 32433.0, 38444.807775960944, 38548.6145138545, 38716.0, 39182.80408597939, 39392.60607393889, 32884.50673239951, 32982.670173297956, 33130.5030424539, 33158.0, 33379.33241335111, 32754.67245327516, 33031.83484082564, 33257.334853302316, 33357.49963750594, 33572.1606959828, 34947.12632184216, 35933.64066359407, 35954.64045359618, 36029.81985090163, 36220.27559448849, 33760.324793504486, 36947.630523695494, 37962.810185948896, 39437.0, 40280.1943961125, 25374.492510150063, 25386.492270154125, 25727.485450290515, 25847.353816154748, 26170.476590467704], "unit": "score", "name": "ext.html", "value": 18279.541090802268}, {"lowerIsBetter": false, "replicates": [339.6722163112596, 343.3579206883129, 343.54308769336785, 357.0, 357.1107941226346, 16835.83164168358, 17334.479965601036, 17484.825151748464, 18600.906995465037, 18751.437456876316, 17243.74134387982, 17710.0, 17834.821651783477, 17843.10784460778, 17848.37530686426, 5270.868228294285, 5349.598780091499, 5448.264484294609, 5453.509184173424, 5460.945390546103, 4020.4170395292663, 4192.937105943413, 5407.918881216785, 5438.945610543903, 5817.447342502476, 6016.368281330463, 6018.277806663206, 6021.337652858182, 6047.697615119248, 6050.757969681207, 5828.475437210672, 5895.410458954113, 5998.760049597989, 6002.159697642312, 6038.547108966845, 3583.122135076897, 3739.439084137374, 3740.214554943438, 5251.291075704808, 5270.525652691276, 16559.751603725952, 18976.81023189764, 19804.80195198044, 19950.700739488773, 21499.67750483744, 2059.4954236212225, 2111.883846388448, 2137.7434707835005, 2183.6287831068757, 2202.053117159621, 12017.579384721494, 13209.0, 13255.0, 13616.795748063787, 13691.931540342333, 1902.4863286912594, 1912.6557219700449, 1946.4160751774411, 1946.4549926020736, 1968.940931772035, 62457.0, 63284.0, 64606.0, 64775.67612161956, 64777.352226477604, 9425.0, 9584.90415095854, 9648.324617276723, 9670.0, 9740.659076932274, 12345.197562158432, 12433.254004759563, 12441.377931103409, 12448.937755311166, 12531.18547294423, 7205.92794072063, 7315.743948961761, 7368.4842061055215, 7442.0, 7447.962760186165, 7207.243239459886, 7236.0, 7257.129144502588, 7306.269373062758, 7307.744228951961, 5979.0, 6026.578139530278, 6054.122152287893, 6063.818085457355, 6078.969605151946, 1560.5084398414463, 1617.967640647204, 1687.1564217891055, 1691.3065643086522, 1742.3901634427848, 983.341161421849, 1001.2940876681922, 1011.22135955314, 1031.8916513765946, 1041.4740556019162, 16626.75059874103, 16971.575710607332, 17197.1401429928, 17526.474205773848, 17696.734548981774, 962.8363178259713, 973.4062222044547, 1028.5937054863437, 1038.5793753529833, 1076.6070384309671, 8898.59956301968, 10256.230782691327, 10309.0, 10318.535665895053, 10329.276950613385, 436739.0, 438985.0, 445880.0, 447219.81950450846, 451742.0, 68033.3196668027, 70389.29610703827, 70543.0, 71516.28483715201, 72535.0, 1008.6520150548049, 1035.052926572178, 1039.9844002339971, 1042.5308611125024, 1069.4813015687384, 12823.61529154127, 15109.39562417491, 15157.317920693375, 15510.767338489706, 15573.987690800062, 30631.846840765655, 31129.844350779007, 31159.84420077885, 31453.528197076605, 31645.208869777518, 40250.0, 40418.0, 40595.188096238504, 40873.38689919594, 41061.38407923824, 7506.512076714996, 7801.921980780119, 7852.293293603603, 7880.763577092696, 7947.3244774194845, 11661.941690291495, 12834.614961551168, 12887.226766394046, 12893.935530322664, 12900.870991290343, 10924.2899211551, 11133.165012624248, 11184.328940263611, 11307.378094204898, 11493.195476316578, 8609.569521524025, 10812.243142979916, 11077.0, 11077.667669969915, 11094.11247100214, 11230.157738169506, 11329.546818127183, 11538.307701537935, 11586.88413115858, 11631.418429078682, 7677.155512893689, 7723.035952063906, 7871.0, 8004.1595632460085, 8061.153578874134, 8994.415363001384, 11143.944280278547, 11343.886561134283, 11345.773084538429, 11353.148513861659], "unit": "score", "name": "jquery.html", "value": 8462.64186720786}, {"lowerIsBetter": false, "replicates": [1321.6629759411348, 1481.570344600066, 1522.3834347089426, 1688.5862963573918, 1850.3986204483547, 7487.550746955187, 7682.270184332479, 7684.269994350535, 7692.769216923487, 7698.230176982299, 7627.19914408986, 7710.961445192766, 7738.690452381912, 7789.454738168331, 7795.649195786189, 1971.053894130818, 2260.5930932432116, 2269.069681430614, 2283.5775381554467, 2337.7895989360954, 2290.393045842853, 2297.7127859017623, 2306.2965795432387, 2306.3888069661552, 2308.826837987158, 2251.898664560099, 2317.9304620861403, 2323.465602911331, 2323.93028209154, 2324.895379707909, 2254.7519772824976, 2286.131270117353, 2305.6426253930667, 2310.653401989698, 2313.0400883633274, 2271.46620544172, 2285.897134628929, 2291.255342013852, 2292.1748170658548, 2325.918592849259, 7730.845383092306, 7806.1413244543055, 7809.3752499799875, 7811.4922530035365, 7824.295813376823, 4776.307435421844, 4935.925961110586, 4952.727599981999, 4963.553280204799, 4963.8262660806695, 3087.938241235185, 3153.495440729472, 3162.067190178903, 3174.1429813950103, 3226.4837625979967, 971.504532688327, 999.115782532464, 999.4652860719481, 1011.7824667696481, 1031.8658574385356, 11028.503717332658, 11039.39283339416, 11044.944775276153, 11048.116150708005, 11064.28082174664, 4364.388985542027, 4487.439070116236, 4499.370088187657, 4538.455385353713, 4552.362669226311, 9312.580933857993, 9372.062793720574, 9378.249740020918, 9391.34260601765, 9398.577064032135, 4328.61042506176, 4863.829765958175, 4879.414470263591, 4892.315075889378, 4912.238603016538, 4342.848000319974, 4409.36064270679, 4428.3800267962515, 4469.754163520973, 4476.619487343547, 3715.64701353371, 3764.4541541476333, 3774.75464094833, 3804.0680033391995, 3821.961780382216, 1156.976860462803, 1183.355071486042, 1191.7259030422879, 1194.4445832687843, 1196.21050106929, 1038.2628333883029, 1045.3571053801857, 1056.8837427882927, 1215.1858254969193, 1376.4012654495327, 7134.857302854018, 7530.0, 7536.924630753732, 7540.924590754132, 7546.509476883985, 1127.4081107418672, 1128.1707944660668, 1128.6614015795228, 1141.851559297286, 1155.2721785275223, 5660.660360378308, 5661.0, 5695.145728140729, 5702.287214098238, 5702.45826646468, 9109.863352049724, 9636.373635713657, 9724.61101555944, 9826.459544724965, 9827.459489728133, 9657.90342096584, 9663.565139568596, 9666.903330966741, 9678.225741940629, 9700.805983880424, 7177.138743350832, 7364.668589913466, 7417.777466676009, 7429.517081389692, 7432.702691892372, 7293.343599076109, 7343.669534870837, 7417.554946703215, 7426.962865185639, 7434.553926764412, 8124.187581242065, 8425.2838508725, 8537.87193192115, 8543.359248056297, 8639.827203456021, 8416.148447341575, 8476.152384761475, 8560.57197140153, 8588.957055214683, 8595.742127736177, 5940.198073260054, 6484.546081774419, 6702.765403210864, 6777.423918966943, 6886.965565172142, 7666.386689064973, 7699.846003080019, 7700.152983171959, 7706.113796913427, 7736.613169341398, 6701.1623547056615, 6807.795766127024, 6818.659067046528, 6978.371946524634, 6988.650567471708, 6857.965710171417, 6890.173179218526, 6908.3437073477935, 7023.964880175567, 7049.612271325126, 7133.072700548895, 7171.103612048494, 7200.531965422231, 7218.27817218274, 7250.9637451812405, 6264.874702505833, 6357.427831495188, 6369.108324834619, 6475.158229430144, 6486.254080780582, 6267.1539342188225, 6325.588836725598, 6371.55399122057, 6376.808695739135, 6379.553431259767], "unit": "score", "name": "mootools.html", "value": 4536.341704082339}, {"lowerIsBetter": false, "replicates": [321.89377505423215, 323.34683938444346, 328.924347400098, 330.65776920886884, 334.81585128179495, 5862.88274234515, 5866.941330586693, 5868.178455016296, 5877.089051197061, 5922.437368449991, 5790.739416726247, 5797.884042319151, 5802.883942321151, 5812.593118481697, 5827.271591051119, 4293.484781826185, 4404.625606823424, 4466.397036400077, 4476.350929115276, 4488.8204471821255, 4442.844500442469, 4465.575770301833, 4479.059397526524, 4480.686351955364, 4496.348029535716, 4289.378040184171, 4445.110977804436, 4476.977615111936, 4483.170613436525, 4492.573205545468, 4374.059577190903, 4462.57605527476, 4497.437820272466, 4498.550144985508, 4504.909901801946, 3907.3943538751255, 3924.823382947774, 3958.7228893977435, 3960.6929713194577, 3976.76139431635, 5495.477929596682, 5498.367687715924, 5499.917501237484, 5503.064479038533, 5513.972430137824, 5192.740362981874, 5216.8695782605355, 5223.294855194538, 5237.266782650432, 5246.0032593807055, 6109.114178444145, 6114.663693496856, 6141.170941922873, 6142.938570614326, 6145.846353841145, 4273.081287523167, 4395.296752519614, 4406.977965110186, 4408.911821763579, 4418.270985287424, 6394.584352017104, 6442.613443193423, 6464.515161362917, 6466.191726034199, 6472.514561407913, 4406.735595864258, 4430.246858034142, 4431.800568974404, 4432.091421258634, 4432.49026361966, 4481.574250446202, 4485.25993211123, 4485.641148708096, 4487.2147374210035, 4489.124620698933, 5182.274481572583, 5183.403908550565, 5184.118699820964, 5192.792288308426, 5193.714345710947, 6053.545984051214, 6247.468965137923, 6254.843628909313, 6260.655663938436, 6272.874542509125, 1599.41621308224, 1600.0799540264395, 1603.262499250358, 1605.8635016023536, 1606.092557704893, 1017.725214192164, 1061.840723891407, 1084.1326938449208, 1117.8379135025539, 1127.7293449572044, 5822.126680997884, 5917.615355001911, 5925.525957923356, 5935.6735379553675, 5937.228160339128, 6245.437910587978, 6284.183056202664, 6286.591371560834, 6286.9056964145575, 6289.40250676185, 5864.472197502245, 5873.471387575139, 5873.58884878063, 5874.265716785402, 5876.206712093898, 3314.668533146666, 3385.4921761735445, 3385.610654774683, 3387.7289816815087, 3393.898183054512, 6595.70319335631, 6633.9668301658185, 6639.136912201479, 6854.246032936373, 6857.759978400732, 6574.3754343337305, 6615.17310336208, 6616.4376028037195, 6617.205935287796, 6620.536562440583, 6813.216480104752, 6814.931850681529, 6816.522843400914, 6828.5902845829405, 6832.6925288362145, 6413.0, 6421.903671445026, 6423.325550817097, 6428.967855160694, 6430.035494675836, 6235.501159907106, 6371.96814015927, 6388.169537960035, 6406.647634379968, 6434.131392261985, 6841.657917104224, 6858.554193977376, 6859.5541289816, 6867.175938887365, 6872.10662613877, 4293.592108749664, 4317.114991426813, 4317.481902171634, 4323.610875021137, 4325.653947684114, 6451.096846441408, 6453.290138084901, 6453.548251622341, 6458.38645328693, 6461.741530338733, 6179.412955769195, 6238.376162383725, 6254.749810007549, 6260.937390626218, 6265.780697675559, 6038.396160383926, 6243.313235544178, 6255.874882502233, 6268.686565671789, 6279.905801413074, 6124.418180272867, 6134.355892631388, 6162.969185154046, 6164.291106522628, 6164.753409863734, 6301.149344838388, 6301.7164227608955, 6301.747930082929, 6307.463865571478, 6311.211098612674, 5888.617239879394, 5953.970230148821, 6160.291566469913, 6161.845953851011, 6167.444929956326], "unit": "score", "name": "prototype.html", "value": 4696.324232897659}, {"lowerIsBetter": false, "replicates": [750.8836130399789, 817.4523069543405, 819.7581713394547, 824.0770337222311, 855.5722138930532, 13711.65720856979, 13948.930255348734, 13956.232407217625, 13982.650433739149, 14018.929905350471, 12790.936045319784, 12819.807702884464, 12835.0, 12842.93578532106, 12862.614121576344, 682.4131247127491, 817.2971244729528, 831.6382373667474, 835.1523203947997, 839.2279103225017, 824.3199360527589, 826.2274773087153, 826.7519744076753, 827.2430725885837, 828.2835347424465, 867.1371984875058, 870.1689886158704, 870.2733217763175, 870.4777133719749, 870.78665726897, 707.073733409233, 860.7417774667606, 864.8745931839911, 880.2385936165235, 881.0704706534603, 645.2934037229227, 648.8345471904681, 651.1990251990031, 651.540663832002, 652.3900153356627, 13842.031057825956, 13856.030077894551, 13906.30468476572, 13922.303884805719, 13942.790858137034, 12820.23078615286, 13079.673008174872, 13202.0, 13250.46998120074, 13399.933000335033, 10556.788864222672, 10563.313384630052, 10677.1992100592, 10798.082163016154, 10829.783404331869, 3597.9820100899587, 3653.1780349421433, 3655.8354874030733, 3664.8534058637624, 3714.5542534895717, 48350.516494834956, 48599.514004859855, 48843.755781221225, 48856.602905738655, 48861.51138488605, 10280.331778434378, 10505.264631475877, 10678.0, 10743.570257189782, 10819.242653014371, 19129.617407651767, 19131.2347506101, 19143.712844307345, 19150.904245478683, 19215.231390744215, 7930.246626570467, 8009.639566219417, 8093.312068474245, 8216.0, 8409.159084091541, 4600.171969045604, 4663.230566956482, 4667.113248482778, 4745.288206768943, 4847.297141914402, 3226.2418331692033, 3234.256121092115, 3237.2554312508255, 3243.0433022258017, 3248.6101667799544, 576.3400905962733, 578.9400638420177, 582.3215953414225, 587.7149582452507, 592.0881841963328, 586.352080950552, 696.8466937273791, 697.9232284448707, 722.8265216348144, 726.6076318787901, 8329.125441828643, 8462.36532260083, 8591.3556483264, 8663.220310172115, 8726.258268047288, 660.3495556876472, 683.54885775389, 697.7883573270308, 710.4777988178685, 717.0427479315068, 3887.475190849256, 4018.678505719535, 4091.365838295069, 4133.627973482401, 4153.854615088518, 56553.0, 57831.0, 58046.0, 58057.4194258052, 58303.708481457325, 52323.73838130785, 52438.47561524412, 52476.999999999236, 52593.0, 52947.73526132345, 44470.33294500585, 45488.77255613701, 45970.31044534335, 46077.7696111524, 46374.0, 7866.0, 7956.84086318282, 7967.083785364757, 8048.5170889746805, 8139.674413023413, 33907.66092339045, 34159.4876076864, 34702.479462807576, 35579.0, 35635.82182089073, 41158.0, 41447.0, 42470.150596988504, 43815.34276985784, 44040.339394909744, 10080.445575493419, 10370.948145259226, 10470.947645261725, 10903.29128606638, 11488.209208424792, 12440.875591244334, 12511.249325040526, 12711.0, 12802.551910683082, 12802.615921522369, 11451.312921224753, 11457.713557161138, 11769.891780788063, 11882.049436045269, 12191.085668574715, 11965.341906195243, 12265.938670306592, 12390.442430090849, 12399.0, 12748.553800616934, 10944.835827462754, 10975.28660637056, 11064.533152774507, 11073.612423565137, 11513.53945842157, 10085.394876307446, 10289.2797504174, 10294.0, 10410.567440373321, 10608.628697995842, 9241.111443083304, 9332.837116983004, 9563.521823908915, 9600.0, 10198.796024079626], "unit": "score", "name": "yui.html", "value": 6447.826293294206}], "name": "dromaeo_css", "value": 6887.670168157512}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 107.0, 110.0, 112.0, 110.0, 101.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 158.0, 162.0, 133.0, 149.0, 152.0, 127.0, 171.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 161.0, 161.0, 159.0, 162.0, 166.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 117.0, 93.0, 74.0, 76.0, 73.0, 108.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 140.0, 95.0, 96.0, 96.0, 145.0, 96.0, 96.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.8}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 144.0, 145.0, 145.0, 145.0, 146.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 57.0, 56.0, 56.0, 59.0, 65.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 85.0, 91.0, 85.0, 85.0, 85.0, 84.0, 84.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 117.0, 116.0, 119.0, 133.0, 129.0, 133.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [160.0, 139.0, 148.0, 154.0, 152.0, 140.0, 149.0, 156.0, 158.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [69.0, 73.0, 72.0, 69.0, 70.0, 71.0, 70.0, 69.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1525.3}]} 17:32:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1525.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6887.67"}}} 17:32:30 INFO - Return code: 0 17:32:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:32:30 INFO - # TBPL SUCCESS # 17:32:30 INFO - Running post-action listener: _resource_record_post_action 17:32:30 INFO - Running post-run listener: _resource_record_post_run 17:32:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 554135552; Read time: 512; Write time: 730172 17:32:31 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 4096; Write bytes: 244879360; Read time: 240; Write time: 500804 17:32:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295936000; Read time: 272; Write time: 227404 17:32:31 INFO - Running post-run listener: _upload_blobber_files 17:32:31 INFO - Blob upload gear active. 17:32:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:32:31 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 17:32:31 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:32:31 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:32:32 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:32:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:32 INFO - (blobuploader) - INFO - Done attempting. 17:32:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:32:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:33 INFO - (blobuploader) - INFO - Done attempting. 17:32:33 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:33 INFO - Return code: 0 17:32:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:32:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93027bf5f1f4151289ad37d2420ab3d3a0402ef1193b96052dc6ded760753e61dbf09233166b199efce249af71b259105a46e936c075f447942e46c12dc409ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eeadbe791170f95cfeac95688e28bd6029ef20b69695339d0a0ad79790928f7f1bb962362a9b41ff206cf5e33e505d77545783259fadaab7ba5f5ea0ac037719"} 17:32:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:32:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:32:33 INFO - Contents: 17:32:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93027bf5f1f4151289ad37d2420ab3d3a0402ef1193b96052dc6ded760753e61dbf09233166b199efce249af71b259105a46e936c075f447942e46c12dc409ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eeadbe791170f95cfeac95688e28bd6029ef20b69695339d0a0ad79790928f7f1bb962362a9b41ff206cf5e33e505d77545783259fadaab7ba5f5ea0ac037719"} 17:32:33 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:33 INFO - Copying logs to upload dir... 17:32:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:32:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.779307 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-25 17:32:33.051559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 17:32:33.054600) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93027bf5f1f4151289ad37d2420ab3d3a0402ef1193b96052dc6ded760753e61dbf09233166b199efce249af71b259105a46e936c075f447942e46c12dc409ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eeadbe791170f95cfeac95688e28bd6029ef20b69695339d0a0ad79790928f7f1bb962362a9b41ff206cf5e33e505d77545783259fadaab7ba5f5ea0ac037719"} build_url:https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/IjjU9P8BReWNnmUwJeKfnA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93027bf5f1f4151289ad37d2420ab3d3a0402ef1193b96052dc6ded760753e61dbf09233166b199efce249af71b259105a46e936c075f447942e46c12dc409ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eeadbe791170f95cfeac95688e28bd6029ef20b69695339d0a0ad79790928f7f1bb962362a9b41ff206cf5e33e505d77545783259fadaab7ba5f5ea0ac037719"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 17:32:33.078683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:32:33.078970) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456448955.588303-1572878260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:32:33.162019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 17:32:33.162361) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 17:32:33.162650) ========= ========= Total master_lag: 0.26 =========