builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1455594674.22 results: success (0) buildid: 20160215173008 builduid: af7e856922634577b5855e5267526756 revision: 1ba422314bc61c2cbf657f8c76ffff7e10a9082e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.220128) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.220565) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.220861) ========= 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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.257694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.258016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.275781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.276044) ========= 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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.336143) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.336443) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.336777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.337055) ========= 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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-15 19:51:14-- 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% 217M=0s 2016-02-15 19:51:14 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.509902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.510190) ========= 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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015842 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.561807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:14.562107) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ba422314bc61c2cbf657f8c76ffff7e10a9082e --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 1ba422314bc61c2cbf657f8c76ffff7e10a9082e --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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-15 19:51:14,756 truncating revision to first 12 chars 2016-02-15 19:51:14,757 Setting DEBUG logging. 2016-02-15 19:51:14,757 attempt 1/10 2016-02-15 19:51:14,757 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ba422314bc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 19:51:15,018 unpacking tar archive at: fx-team-1ba422314bc6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565528 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:15.141849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:15.142283) ========= echo 1ba422314bc61c2cbf657f8c76ffff7e10a9082e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1ba422314bc61c2cbf657f8c76ffff7e10a9082e'] 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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1ba422314bc61c2cbf657f8c76ffff7e10a9082e program finished with exit code 0 elapsedTime=0.004616 script_repo_revision: '1ba422314bc61c2cbf657f8c76ffff7e10a9082e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:15.194941) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:15.195210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 19:51:15.215885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-15 19:51:15.216145) ========= /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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:51:15 INFO - MultiFileLogger online at 20160215 19:51:15 in /builds/slave/test-pgo 19:51:15 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 19:51:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:51:15 INFO - {'append_to_log': False, 19:51:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:51:15 INFO - 'blob_upload_branch': 'Fx-Team', 19:51:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:51:15 INFO - 'branch': 'Fx-Team', 19:51:15 INFO - 'buildbot_json_path': 'buildprops.json', 19:51:15 INFO - 'config_files': ('talos/linux_config.py',), 19:51:15 INFO - 'default_actions': ('clobber', 19:51:15 INFO - 'read-buildbot-config', 19:51:15 INFO - 'download-and-extract', 19:51:15 INFO - 'populate-webroot', 19:51:15 INFO - 'create-virtualenv', 19:51:15 INFO - 'install', 19:51:15 INFO - 'run-tests'), 19:51:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:51:15 INFO - 'download_minidump_stackwalk': True, 19:51:15 INFO - 'download_symbols': 'ondemand', 19:51:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:51:15 INFO - 'tooltool.py': '/tools/tooltool.py', 19:51:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:51:15 INFO - '/tools/misc-python/virtualenv.py')}, 19:51:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:51:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:51:15 INFO - 'installer_path': 'installer.exe', 19:51:15 INFO - 'log_level': 'info', 19:51:15 INFO - 'log_name': 'talos', 19:51:15 INFO - 'log_to_console': True, 19:51:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:51:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:51:15 INFO - 'opt_config_files': (), 19:51:15 INFO - 'pip_index': False, 19:51:15 INFO - 'sps_profile': False, 19:51:15 INFO - 'sps_profile_interval': 0, 19:51:15 INFO - 'suite': 'dromaeojs', 19:51:15 INFO - 'system_bits': '32', 19:51:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:51:15 INFO - 'title': 'talos-linux64-ix-054', 19:51:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:51:15 INFO - 'use_talos_json': True, 19:51:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:51:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:51:15 INFO - 'work_dir': 'build'} 19:51:15 INFO - ##### 19:51:15 INFO - ##### Running clobber step. 19:51:15 INFO - ##### 19:51:15 INFO - Running pre-action listener: _resource_record_pre_action 19:51:15 INFO - Running main action method: clobber 19:51:15 INFO - rmtree: /builds/slave/test-pgo/build 19:51:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:51:16 INFO - Running post-action listener: _resource_record_post_action 19:51:16 INFO - ##### 19:51:16 INFO - ##### Running read-buildbot-config step. 19:51:16 INFO - ##### 19:51:16 INFO - Running pre-action listener: _resource_record_pre_action 19:51:16 INFO - Running main action method: read_buildbot_config 19:51:16 INFO - Using buildbot properties: 19:51:16 INFO - { 19:51:16 INFO - "project": "", 19:51:16 INFO - "product": "firefox", 19:51:16 INFO - "script_repo_revision": "production", 19:51:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:51:16 INFO - "repository": "", 19:51:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:51:16 INFO - "buildid": "20160215173008", 19:51:16 INFO - "pgo_build": "True", 19:51:16 INFO - "basedir": "/builds/slave/test-pgo", 19:51:16 INFO - "buildnumber": 944, 19:51:16 INFO - "slavename": "talos-linux64-ix-054", 19:51:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:51:16 INFO - "platform": "ubuntu64_hw", 19:51:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:51:16 INFO - "branch": "fx-team", 19:51:16 INFO - "repo_path": "integration/fx-team", 19:51:16 INFO - "revision": "1ba422314bc61c2cbf657f8c76ffff7e10a9082e", 19:51:16 INFO - "stage_platform": "linux64-pgo", 19:51:16 INFO - "builduid": "af7e856922634577b5855e5267526756", 19:51:16 INFO - "slavebuilddir": "test" 19:51:16 INFO - } 19:51:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:51:16 INFO - Running post-action listener: _resource_record_post_action 19:51:16 INFO - ##### 19:51:16 INFO - ##### Running download-and-extract step. 19:51:16 INFO - ##### 19:51:16 INFO - Running pre-action listener: _resource_record_pre_action 19:51:16 INFO - Running main action method: download_and_extract 19:51:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:16 INFO - https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:51:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/test_packages.json 19:51:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/test_packages.json 19:51:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:51:18 INFO - Downloaded 1448 bytes. 19:51:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:51:18 INFO - Using the following test package requirements: 19:51:18 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:51:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:51:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'jsshell-linux-x86_64.zip'], 19:51:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:51:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:51:18 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:51:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:51:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:51:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:18 INFO - https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:19 INFO - Downloaded 23342768 bytes. 19:51:19 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'] 19:51:19 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 19:51:20 INFO - Return code: 0 19:51:20 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 19:51: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')]} 19:51:20 INFO - https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:25 INFO - Downloaded 23342768 bytes. 19:51:25 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'] 19:51:25 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 19:51:26 INFO - Return code: 0 19:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:26 INFO - https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:51:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:27 INFO - Downloaded 10707070 bytes. 19:51:27 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'] 19:51:27 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 19:51:27 INFO - Return code: 0 19:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:27 INFO - https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:51:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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 19:51:28 INFO - Downloaded 56498393 bytes. 19:51:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:28 INFO - mkdir: /builds/slave/test-pgo/properties 19:51:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:51:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:51:28 INFO - Contents: 19:51:28 INFO - build_url:https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:29 INFO - Running post-action listener: _resource_record_post_action 19:51:29 INFO - Running post-action listener: set_extra_try_arguments 19:51:29 INFO - ##### 19:51:29 INFO - ##### Running populate-webroot step. 19:51:29 INFO - ##### 19:51:29 INFO - Running pre-action listener: _resource_record_pre_action 19:51:29 INFO - Running main action method: populate_webroot 19:51:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:29 INFO - '--tppagecycles', 19:51:29 INFO - '7'], 19:51:29 INFO - 'tests': ['tsvgm']}}, 19:51:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:51:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:51:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:51:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'tests': ['damp', 'tps']}, 19:51:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['damp', 'tps']}, 19:51:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:51:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:29 INFO - 'other': {'tests': ['a11yr', 19:51:29 INFO - 'ts_paint', 19:51:29 INFO - 'tpaint', 19:51:29 INFO - 'sessionrestore', 19:51:29 INFO - 'sessionrestore_no_auto_restore']}, 19:51:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['a11yr', 19:51:29 INFO - 'ts_paint', 19:51:29 INFO - 'tpaint', 19:51:29 INFO - 'sessionrestore', 19:51:29 INFO - 'sessionrestore_no_auto_restore']}, 19:51:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['a11yr', 19:51:29 INFO - 'ts_paint', 19:51:29 INFO - 'tpaint', 19:51:29 INFO - 'sessionrestore', 19:51:29 INFO - 'sessionrestore_no_auto_restore']}, 19:51:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['a11yr', 19:51:29 INFO - 'ts_paint', 19:51:29 INFO - 'tpaint', 19:51:29 INFO - 'sessionrestore', 19:51:29 INFO - 'sessionrestore_no_auto_restore']}, 19:51:29 INFO - 'other_l64': {'tests': ['a11yr', 19:51:29 INFO - 'ts_paint', 19:51:29 INFO - 'tpaint', 19:51:29 INFO - 'sessionrestore', 19:51:29 INFO - 'sessionrestore_no_auto_restore']}, 19:51:29 INFO - 'other_nol64': {'tests': ['a11yr', 19:51:29 INFO - 'ts_paint', 19:51:29 INFO - 'tpaint', 19:51:29 INFO - 'sessionrestore', 19:51:29 INFO - 'sessionrestore_no_auto_restore']}, 19:51:29 INFO - 'svgr': {'tests': ['tsvgx', 19:51:29 INFO - 'tsvgr_opacity', 19:51:29 INFO - 'tart', 19:51:29 INFO - 'tscrollx', 19:51:29 INFO - 'cart']}, 19:51:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['tsvgx', 19:51:29 INFO - 'tsvgr_opacity', 19:51:29 INFO - 'tart', 19:51:29 INFO - 'tscrollx', 19:51:29 INFO - 'cart']}, 19:51:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'tests': ['tp5o']}, 19:51:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'talos_options': ['--e10s'], 19:51:29 INFO - 'tests': ['tp5o']}, 19:51:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'talos_options': ['--xperf_path', 19:51:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:29 INFO - 'tests': ['tp5n']}, 19:51:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:29 INFO - 'talos_options': ['--e10s', 19:51:29 INFO - '--xperf_path', 19:51:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:29 INFO - 'tests': ['tp5n']}}, 19:51:29 INFO - 'talos.zip': {'path': '', 19:51:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:29 INFO - Running post-action listener: _resource_record_post_action 19:51:29 INFO - ##### 19:51:29 INFO - ##### Running create-virtualenv step. 19:51:29 INFO - ##### 19:51:29 INFO - Running pre-action listener: _resource_record_pre_action 19:51:29 INFO - Running main action method: create_virtualenv 19:51:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:51:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:51:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:51:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:29 INFO - Using real prefix '/usr' 19:51:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:51:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:32 INFO - Installing pip.................done. 19:51:32 INFO - Return code: 0 19:51:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:32 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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:51:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:51:32 INFO - Using env: {'DISPLAY': ':0', 19:51:32 INFO - 'HOME': '/home/cltbld', 19:51:32 INFO - 'LANG': 'en_US.UTF-8', 19:51:32 INFO - 'LANGUAGE': 'en_US:en', 19:51:32 INFO - 'LOGNAME': 'cltbld', 19:51:32 INFO - 'MAIL': '/var/mail/cltbld', 19:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:32 INFO - 'MOZ_NO_REMOTE': '1', 19:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:32 INFO - 'NO_EM_RESTART': '1', 19:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:32 INFO - 'SHELL': '/bin/bash', 19:51:32 INFO - 'SHLVL': '1', 19:51:32 INFO - 'TERM': 'linux', 19:51:32 INFO - 'TMOUT': '86400', 19:51:32 INFO - 'USER': 'cltbld', 19:51:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:32 INFO - '_': '/tools/buildbot/bin/python'} 19:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:51:32 INFO - Cleaning up... 19:51:32 INFO - Return code: 0 19:51:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:32 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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:51:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:51:32 INFO - Using env: {'DISPLAY': ':0', 19:51:32 INFO - 'HOME': '/home/cltbld', 19:51:32 INFO - 'LANG': 'en_US.UTF-8', 19:51:32 INFO - 'LANGUAGE': 'en_US:en', 19:51:32 INFO - 'LOGNAME': 'cltbld', 19:51:32 INFO - 'MAIL': '/var/mail/cltbld', 19:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:32 INFO - 'MOZ_NO_REMOTE': '1', 19:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:32 INFO - 'NO_EM_RESTART': '1', 19:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:32 INFO - 'SHELL': '/bin/bash', 19:51:32 INFO - 'SHLVL': '1', 19:51:32 INFO - 'TERM': 'linux', 19:51:32 INFO - 'TMOUT': '86400', 19:51:32 INFO - 'USER': 'cltbld', 19:51:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:32 INFO - '_': '/tools/buildbot/bin/python'} 19:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:32 INFO - Downloading/unpacking psutil>=0.7.1 19:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:34 INFO - Installing collected packages: psutil 19:51:34 INFO - Running setup.py install for psutil 19:51:34 INFO - building 'psutil._psutil_linux' extension 19:51:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:51:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:51:34 INFO - building 'psutil._psutil_posix' extension 19:51:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:51:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:51:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:35 INFO - Successfully installed psutil 19:51:35 INFO - Cleaning up... 19:51:35 INFO - Return code: 0 19:51:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', '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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:51: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 mozsystemmonitor==0.0.0 19:51:35 INFO - Using env: {'DISPLAY': ':0', 19:51:35 INFO - 'HOME': '/home/cltbld', 19:51:35 INFO - 'LANG': 'en_US.UTF-8', 19:51:35 INFO - 'LANGUAGE': 'en_US:en', 19:51:35 INFO - 'LOGNAME': 'cltbld', 19:51:35 INFO - 'MAIL': '/var/mail/cltbld', 19:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:35 INFO - 'MOZ_NO_REMOTE': '1', 19:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:35 INFO - 'NO_EM_RESTART': '1', 19:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:35 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:35 INFO - 'SHELL': '/bin/bash', 19:51:35 INFO - 'SHLVL': '1', 19:51:35 INFO - 'TERM': 'linux', 19:51:35 INFO - 'TMOUT': '86400', 19:51:35 INFO - 'USER': 'cltbld', 19:51:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:35 INFO - '_': '/tools/buildbot/bin/python'} 19:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:51:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:51:37 INFO - Installing collected packages: mozsystemmonitor 19:51:37 INFO - Running setup.py install for mozsystemmonitor 19:51:37 INFO - Successfully installed mozsystemmonitor 19:51:37 INFO - Cleaning up... 19:51:37 INFO - Return code: 0 19:51:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:37 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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:51:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:51:37 INFO - Using env: {'DISPLAY': ':0', 19:51:37 INFO - 'HOME': '/home/cltbld', 19:51:37 INFO - 'LANG': 'en_US.UTF-8', 19:51:37 INFO - 'LANGUAGE': 'en_US:en', 19:51:37 INFO - 'LOGNAME': 'cltbld', 19:51:37 INFO - 'MAIL': '/var/mail/cltbld', 19:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:37 INFO - 'MOZ_NO_REMOTE': '1', 19:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:37 INFO - 'NO_EM_RESTART': '1', 19:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:37 INFO - 'SHELL': '/bin/bash', 19:51:37 INFO - 'SHLVL': '1', 19:51:37 INFO - 'TERM': 'linux', 19:51:37 INFO - 'TMOUT': '86400', 19:51:37 INFO - 'USER': 'cltbld', 19:51:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:37 INFO - '_': '/tools/buildbot/bin/python'} 19:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:40 INFO - Downloading docopt-0.6.1.tar.gz 19:51:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:40 INFO - Running setup.py install for blobuploader 19:51:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:51:40 INFO - Running setup.py install for requests 19:51:40 INFO - Running setup.py install for docopt 19:51:40 INFO - Successfully installed blobuploader requests docopt 19:51:40 INFO - Cleaning up... 19:51:40 INFO - Return code: 0 19:51:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:40 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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:51:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:40 INFO - Using env: {'DISPLAY': ':0', 19:51:40 INFO - 'HOME': '/home/cltbld', 19:51:40 INFO - 'LANG': 'en_US.UTF-8', 19:51:40 INFO - 'LANGUAGE': 'en_US:en', 19:51:40 INFO - 'LOGNAME': 'cltbld', 19:51:40 INFO - 'MAIL': '/var/mail/cltbld', 19:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:40 INFO - 'MOZ_NO_REMOTE': '1', 19:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:40 INFO - 'NO_EM_RESTART': '1', 19:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:40 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:40 INFO - 'SHELL': '/bin/bash', 19:51:40 INFO - 'SHLVL': '1', 19:51:40 INFO - 'TERM': 'linux', 19:51:40 INFO - 'TMOUT': '86400', 19:51:40 INFO - 'USER': 'cltbld', 19:51:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:40 INFO - '_': '/tools/buildbot/bin/python'} 19:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:40 INFO - Running setup.py (path:/tmp/pip-ht1ltw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:41 INFO - Running setup.py (path:/tmp/pip-8SW2p3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:41 INFO - Running setup.py (path:/tmp/pip-xbCkpr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:41 INFO - Running setup.py (path:/tmp/pip-3MOlgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:41 INFO - Running setup.py (path:/tmp/pip-ABl94N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:41 INFO - Running setup.py (path:/tmp/pip-Vfcrfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:41 INFO - Running setup.py (path:/tmp/pip-YuqVYo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:41 INFO - Running setup.py (path:/tmp/pip-VtjoVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:41 INFO - Running setup.py (path:/tmp/pip-adtvZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:41 INFO - Running setup.py (path:/tmp/pip-6GJwwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:41 INFO - Running setup.py (path:/tmp/pip-uIpB1O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:41 INFO - Running setup.py (path:/tmp/pip-u4hc3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:41 INFO - Running setup.py (path:/tmp/pip-ZzO8e3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:41 INFO - Running setup.py (path:/tmp/pip-xcnm_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:41 INFO - Running setup.py (path:/tmp/pip-XXoCM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:42 INFO - Running setup.py (path:/tmp/pip-a_1dlk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:42 INFO - Running setup.py (path:/tmp/pip-kYCpgX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:42 INFO - Running setup.py install for manifestparser 19:51:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Running setup.py install for mozcrash 19:51:42 INFO - Running setup.py install for mozdebug 19:51:42 INFO - Running setup.py install for mozdevice 19:51:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Running setup.py install for mozfile 19:51:42 INFO - Running setup.py install for mozhttpd 19:51:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Running setup.py install for mozinfo 19:51:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Running setup.py install for mozInstall 19:51:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:51:42 INFO - Running setup.py install for mozleak 19:51:43 INFO - Running setup.py install for mozlog 19:51:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:51:43 INFO - Running setup.py install for moznetwork 19:51:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:51:43 INFO - Running setup.py install for mozprocess 19:51:43 INFO - Running setup.py install for mozprofile 19:51:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:51:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:51:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:51:43 INFO - Running setup.py install for mozrunner 19:51:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:51:43 INFO - Running setup.py install for mozscreenshot 19:51:43 INFO - Running setup.py install for moztest 19:51:43 INFO - Running setup.py install for mozversion 19:51:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:51:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:43 INFO - Cleaning up... 19:51:43 INFO - Return code: 0 19:51:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:43 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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:51:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:43 INFO - Using env: {'DISPLAY': ':0', 19:51:43 INFO - 'HOME': '/home/cltbld', 19:51:43 INFO - 'LANG': 'en_US.UTF-8', 19:51:43 INFO - 'LANGUAGE': 'en_US:en', 19:51:43 INFO - 'LOGNAME': 'cltbld', 19:51:43 INFO - 'MAIL': '/var/mail/cltbld', 19:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:43 INFO - 'MOZ_NO_REMOTE': '1', 19:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:43 INFO - 'NO_EM_RESTART': '1', 19:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:43 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:43 INFO - 'SHELL': '/bin/bash', 19:51:43 INFO - 'SHLVL': '1', 19:51:43 INFO - 'TERM': 'linux', 19:51:43 INFO - 'TMOUT': '86400', 19:51:43 INFO - 'USER': 'cltbld', 19:51:43 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:43 INFO - '_': '/tools/buildbot/bin/python'} 19:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:44 INFO - Running setup.py (path:/tmp/pip-lghHY1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:44 INFO - Running setup.py (path:/tmp/pip-aBhrKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:44 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)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:44 INFO - Running setup.py (path:/tmp/pip-UkPAI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:44 INFO - Running setup.py (path:/tmp/pip-si1qCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:44 INFO - Running setup.py (path:/tmp/pip-WKbPm7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:44 INFO - Running setup.py (path:/tmp/pip-1SQVhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:44 INFO - Running setup.py (path:/tmp/pip-YlyOSV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:44 INFO - Running setup.py (path:/tmp/pip-Qf36cV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:44 INFO - Running setup.py (path:/tmp/pip-5zDibO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:44 INFO - Running setup.py (path:/tmp/pip-gDhn6i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:44 INFO - Running setup.py (path:/tmp/pip-l4oluc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:44 INFO - Running setup.py (path:/tmp/pip-BDEDFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:45 INFO - Running setup.py (path:/tmp/pip-Bnww46-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:45 INFO - Running setup.py (path:/tmp/pip-1hhTz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:45 INFO - Running setup.py (path:/tmp/pip-vjbAKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:45 INFO - Running setup.py (path:/tmp/pip-9qfizl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:45 INFO - Running setup.py (path:/tmp/pip-K6ydnf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:51:45 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)) 19:51:45 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)) 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:47 INFO - Downloading blessings-1.6.tar.gz 19:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:47 INFO - Installing collected packages: blessings 19:51:47 INFO - Running setup.py install for blessings 19:51:47 INFO - Successfully installed blessings 19:51:47 INFO - Cleaning up... 19:51:47 INFO - Return code: 0 19:51:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:51:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:47 INFO - Reading from file tmpfile_stdout 19:51:47 INFO - Current package versions: 19:51:47 INFO - argparse == 1.2.1 19:51:47 INFO - blessings == 1.6 19:51:47 INFO - blobuploader == 1.2.4 19:51:47 INFO - docopt == 0.6.1 19:51:47 INFO - manifestparser == 1.1 19:51:47 INFO - mozInstall == 1.12 19:51:47 INFO - mozcrash == 0.16 19:51:47 INFO - mozdebug == 0.1 19:51:47 INFO - mozdevice == 0.48 19:51:47 INFO - mozfile == 1.2 19:51:47 INFO - mozhttpd == 0.7 19:51:47 INFO - mozinfo == 0.9 19:51:47 INFO - mozleak == 0.1 19:51:47 INFO - mozlog == 3.1 19:51:47 INFO - moznetwork == 0.27 19:51:47 INFO - mozprocess == 0.22 19:51:47 INFO - mozprofile == 0.28 19:51:47 INFO - mozrunner == 6.11 19:51:47 INFO - mozscreenshot == 0.1 19:51:47 INFO - mozsystemmonitor == 0.0 19:51:47 INFO - moztest == 0.7 19:51:47 INFO - mozversion == 1.4 19:51:47 INFO - psutil == 3.1.1 19:51:47 INFO - requests == 1.2.3 19:51:47 INFO - wsgiref == 0.1.2 19:51:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:51:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:47 INFO - Using env: {'DISPLAY': ':0', 19:51:47 INFO - 'HOME': '/home/cltbld', 19:51:47 INFO - 'LANG': 'en_US.UTF-8', 19:51:47 INFO - 'LANGUAGE': 'en_US:en', 19:51:47 INFO - 'LOGNAME': 'cltbld', 19:51:47 INFO - 'MAIL': '/var/mail/cltbld', 19:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:47 INFO - 'MOZ_NO_REMOTE': '1', 19:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:47 INFO - 'NO_EM_RESTART': '1', 19:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:47 INFO - 'SHELL': '/bin/bash', 19:51:47 INFO - 'SHLVL': '1', 19:51:47 INFO - 'TERM': 'linux', 19:51:47 INFO - 'TMOUT': '86400', 19:51:47 INFO - 'USER': 'cltbld', 19:51:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:47 INFO - '_': '/tools/buildbot/bin/python'} 19:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:51:47 INFO - Cleaning up... 19:51:47 INFO - Return code: 0 19:51:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 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 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:51:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:51:47 INFO - Using env: {'DISPLAY': ':0', 19:51:47 INFO - 'HOME': '/home/cltbld', 19:51:47 INFO - 'LANG': 'en_US.UTF-8', 19:51:47 INFO - 'LANGUAGE': 'en_US:en', 19:51:47 INFO - 'LOGNAME': 'cltbld', 19:51:47 INFO - 'MAIL': '/var/mail/cltbld', 19:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:47 INFO - 'MOZ_NO_REMOTE': '1', 19:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:47 INFO - 'NO_EM_RESTART': '1', 19:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:47 INFO - 'SHELL': '/bin/bash', 19:51:47 INFO - 'SHLVL': '1', 19:51:47 INFO - 'TERM': 'linux', 19:51:47 INFO - 'TMOUT': '86400', 19:51:47 INFO - 'USER': 'cltbld', 19:51:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:47 INFO - '_': '/tools/buildbot/bin/python'} 19:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:48 INFO - Downloading/unpacking jsonschema 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:49 INFO - Downloading/unpacking functools32 (from jsonschema) 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:50 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:50 INFO - warning: no files found matching '*.txt' 19:51:50 INFO - no previously-included directories found matching 'build' 19:51:50 INFO - no previously-included directories found matching 'dist' 19:51:50 INFO - no previously-included directories found matching '.git*' 19:51:50 INFO - Installing collected packages: jsonschema, functools32 19:51:50 INFO - Running setup.py install for functools32 19:51:50 INFO - warning: no files found matching '*.txt' 19:51:50 INFO - no previously-included directories found matching 'build' 19:51:50 INFO - no previously-included directories found matching 'dist' 19:51:50 INFO - no previously-included directories found matching '.git*' 19:51:50 INFO - Successfully installed jsonschema functools32 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88b2faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, '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': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:51:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:51:50 INFO - Using env: {'DISPLAY': ':0', 19:51:50 INFO - 'HOME': '/home/cltbld', 19:51:50 INFO - 'LANG': 'en_US.UTF-8', 19:51:50 INFO - 'LANGUAGE': 'en_US:en', 19:51:50 INFO - 'LOGNAME': 'cltbld', 19:51:50 INFO - 'MAIL': '/var/mail/cltbld', 19:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:50 INFO - 'MOZ_NO_REMOTE': '1', 19:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:50 INFO - 'NO_EM_RESTART': '1', 19:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:50 INFO - 'SHELL': '/bin/bash', 19:51:50 INFO - 'SHLVL': '1', 19:51:50 INFO - 'TERM': 'linux', 19:51:50 INFO - 'TMOUT': '86400', 19:51:50 INFO - 'USER': 'cltbld', 19:51:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:50 INFO - '_': '/tools/buildbot/bin/python'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 INFO - Downloading/unpacking flake8 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:51:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:51:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:51:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:52 INFO - no previously-included directories found matching 'docs/_build' 19:51:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:51:53 INFO - Running setup.py install for pep8 19:51:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:53 INFO - no previously-included directories found matching 'docs/_build' 19:51:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:51:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:51:53 INFO - Cleaning up... 19:51:53 INFO - Return code: 0 19:51:53 INFO - Running post-action listener: _resource_record_post_action 19:51:53 INFO - Running post-action listener: _start_resource_monitoring 19:51:53 INFO - Starting resource monitoring. 19:51:53 INFO - ##### 19:51:53 INFO - ##### Running install step. 19:51:53 INFO - ##### 19:51:53 INFO - Running pre-action listener: _resource_record_pre_action 19:51:53 INFO - Running main action method: install 19:51:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:53 INFO - Reading from file tmpfile_stdout 19:51:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:51:53 INFO - Reading from file tmpfile_stdout 19:51:53 INFO - Output received: 19:51:53 INFO - Usage: mozinstall [options] installer 19:51:53 INFO - Options: 19:51:53 INFO - -h, --help show this help message and exit 19:51:53 INFO - -d DEST, --destination=DEST 19:51:53 INFO - Directory to install application into. [default: 19:51:53 INFO - "/builds/slave/test-pgo"] 19:51:53 INFO - --app=APP Application being installed. [default: firefox] 19:51:53 INFO - mkdir: /builds/slave/test-pgo/build/application 19:51:53 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'] 19:51:53 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 19:52:09 INFO - Reading from file tmpfile_stdout 19:52:09 INFO - Output received: 19:52:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:52:09 INFO - Running post-action listener: _resource_record_post_action 19:52:09 INFO - ##### 19:52:09 INFO - ##### Running run-tests step. 19:52:09 INFO - ##### 19:52:09 INFO - Running pre-action listener: _resource_record_pre_action 19:52:09 INFO - Running main action method: run_tests 19:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:52:09 INFO - Python 2.7.3 19:52:09 INFO - Return code: 0 19:52:09 INFO - grabbing minidump binary from tooltool 19:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:52:09 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 0x160e8c0>, '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 0x160f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:52:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:52:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:52:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:09 INFO - Return code: 0 19:52:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:52:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:52:10 INFO - Return code: 0 19:52:10 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/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:52:10 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/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:52:10 INFO - Using env: {'DISPLAY': ':0', 19:52:10 INFO - 'HOME': '/home/cltbld', 19:52:10 INFO - 'LANG': 'en_US.UTF-8', 19:52:10 INFO - 'LANGUAGE': 'en_US:en', 19:52:10 INFO - 'LOGNAME': 'cltbld', 19:52:10 INFO - 'MAIL': '/var/mail/cltbld', 19:52:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:10 INFO - 'MOZ_NO_REMOTE': '1', 19:52:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:10 INFO - 'NO_EM_RESTART': '1', 19:52:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:52:10 INFO - 'SHELL': '/bin/bash', 19:52:10 INFO - 'SHLVL': '1', 19:52:10 INFO - 'TERM': 'linux', 19:52:10 INFO - 'TMOUT': '86400', 19:52:10 INFO - 'USER': 'cltbld', 19:52:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294', 19:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:10 INFO - '_': '/tools/buildbot/bin/python'} 19:52:10 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/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:52:11 INFO - mozversion application_buildid: 20160215173008 19:52:11 INFO - mozversion application_changeset: 1ba422314bc61c2cbf657f8c76ffff7e10a9082e 19:52:11 INFO - mozversion application_display_name: Nightly 19:52:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:11 INFO - mozversion application_name: Firefox 19:52:11 INFO - mozversion application_remotingname: firefox 19:52:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:52:11 INFO - mozversion application_vendor: Mozilla 19:52:11 INFO - mozversion application_version: 47.0a1 19:52:11 INFO - mozversion platform_buildid: 20160215173008 19:52:11 INFO - mozversion platform_changeset: 1ba422314bc61c2cbf657f8c76ffff7e10a9082e 19:52:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:52:11 INFO - mozversion platform_version: 47.0a1 19:52:11 INFO - using testdate: 1455594731 19:52:11 INFO - actual date: 1455594731 19:52:11 INFO - starting webserver on 'localhost:60300' 19:52:11 INFO - SUITE-START | Running 2 tests 19:52:11 INFO - TEST-START | dromaeo_css 19:52:11 INFO - operating with platform_type : linux_ 19:52:11 INFO - Initialising browser for dromaeo_css test... 19:52:11 INFO - TEST-INFO | started process 2292 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEdnpT6/profile http://localhost:60300/getInfo.html) 19:52:15 INFO - PROCESS | 2292 | __metrics Screen width/height:1600/1200 19:52:15 INFO - PROCESS | 2292 | colorDepth:24 19:52:15 INFO - PROCESS | 2292 | Browser inner width/height: 1024/697 19:52:15 INFO - PROCESS | 2292 | __metrics 19:52:16 INFO - PROCESS | 2292 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:17 INFO - TEST-INFO | 2292: exit 0 19:52:17 INFO - Browser initialized. 19:52:17 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:17 INFO - TEST-INFO | started process 2460 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEdnpT6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:29 INFO - PROCESS | 2460 | RSS: Main: 148471808 19:52:29 INFO - PROCESS | 2460 | 19:53:20 INFO - PROCESS | 2460 | 1455594800905 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:55:29 INFO - PROCESS | 2460 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60300/tests/dromaeo/cssquery-ext.html) 19:55:30 INFO - PROCESS | 2460 | RSS: Main: 240508928 19:55:30 INFO - PROCESS | 2460 | 19:58:32 INFO - PROCESS | 2460 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-ext.html (next: http://localhost:60300/tests/dromaeo/cssquery-jquery.html) 19:58:33 INFO - PROCESS | 2460 | RSS: Main: 235663360 19:58:33 INFO - PROCESS | 2460 | 20:01:35 INFO - PROCESS | 2460 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60300/tests/dromaeo/cssquery-mootools.html) 20:01:35 INFO - PROCESS | 2460 | RSS: Main: 237764608 20:01:35 INFO - PROCESS | 2460 | 20:04:37 INFO - PROCESS | 2460 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60300/tests/dromaeo/cssquery-prototype.html) 20:04:38 INFO - PROCESS | 2460 | RSS: Main: 211828736 20:04:38 INFO - PROCESS | 2460 | 20:07:40 INFO - PROCESS | 2460 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60300/tests/dromaeo/cssquery-yui.html) 20:07:41 INFO - PROCESS | 2460 | RSS: Main: 216125440 20:07:41 INFO - PROCESS | 2460 | 20:10:43 INFO - PROCESS | 2460 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-yui.html (next: http://localhost:60300/tests/dromaeo/cssquery-dojo.html) 20:10:44 INFO - PROCESS | 2460 | RSS: Main: 285102080 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | __start_tp_report 20:10:44 INFO - PROCESS | 2460 | _x_x_mozilla_page_load 20:10:44 INFO - PROCESS | 2460 | _x_x_mozilla_page_load_details 20:10:44 INFO - PROCESS | 2460 | |i|pagename|runs| 20:10:44 INFO - PROCESS | 2460 | |0;dojo.html;3142.842857857107;3152.7950683205604;3187.107609869236;3187.5378070179822;3217.4530329843924;4972.428170760355;5099.439061703214;5110;5116.104681680705;5116.155834287338;5022.598192144629;5123.052235336465;5182.274481572583;5200.609954253437;5216.66091704039;4640.2343613303765;4659.976700116495;4668.813247470097;4672.953270467303;4760.047990401916;4659.580637742602;4797.808087676489;4811.13399588074;4837.782299796518;4883.682560633565;4564.726116433025;4642.280446530793;4661;4766.7616619169075;4806.543378379066;4651.44182698075;4680.789364478606;4685.344051832746;4685.461171965199;4686.343911852344;4631.2126938420215;4653.092646933849;4654.325122857201;4654.348391225198;4660.906781864343;4897.657163998521;4947.208446648555;4971.204607262856;4991.950080499185;5008.398992120932;5470.890582188334;5473.616846820724;5480.451954804527;5481.890362192774;5485.588580856412;5391.218273350342;5419.972900135514;5503.752331145068;5549.916751248735;5567.331920169565;5176.275321454999;5208.661437006583;5213.5829133669595;5216.3218781558535;5251.973740131313;5568.109102543654;5586;5607.7476513556985;5610.242617246619;5613.915791263134;5355.571554275649;5412.78348866041;5424.430434804368;5428.7557059931605;5435.320584926884;5501.972490137524;5507.146392309199;5511.063119269734;5522.834314970557;5542.085555883315;5468.425815289417;5475.945240547623;5502.422245664227;5503.3120859892515;5554.805581804699;5418.810341638024;5499.725013749377;5501.697406642593;5512.118061110284;5591.30108736408;4305.56944305567;4305.91388172241;4314.525402205755;4315.3742707307265;4340.457442819647;3851.9422208666892;3860.285847118292;3877.166409222031;3890.5331360236387;3895.3962135868987;4995.150824359795;5072.594192464594;5077.162268225775;5127.435982041972;5164.741762911839;5525.11598144295;5539.41836107211;5549.500544950974;5573.27547418833;5575.470330318613;5041.773120209599;5129.384473863086;5146.871328216825;5162.535371816554;5204.609654275944;4635.026644404646;4733.715977041388;4787.497312782108;4799.66402351839;4813.181759100961;5676.545876329967;5683.403242659544;5686.630369026;5687.971560142173;5688.175214593861;5422.8373148805595;5472.370677372153;5483.122700367922;5487.6158668892795;5543.1962365455975;5567.944320556742;5664.575156863334;5808.273965754281;5858.794942177004;5911.556633252438;5445.700486473282;5449.836504904859;5450.400455949763;5452.291202143696;5453.945460545502;5415.160650099241;5503.587230957614;5511.145772405283;5526.281583394294;5564.972175139098;5310.946890531045;5325.920111198413;5330.70681112527;5333;5377.677339359651;5310.442403547572;5359.356877174764;5368.22160786676;5392.164214546751;5437.429069947757;5233.947660523346;5287.841364759063;5294.602904782234;5300.098983172793;5328.866778330573;5349.411564727955;5377.516023557899;5396.244525766318;5433.049216387038;5460;5273.578113750814;5274.050670879278;5277.340332458442;5278.498542638443;5279.973600131974 20:10:44 INFO - PROCESS | 2460 | |1;ext.html;510.53286243087575;529.7218960045977;562.9634073785204;568.1789813719178;586.630422833615;28194.15417537472;28736.568951465746;35902.820485897566;36015.4597681035;36020.459693104625;39536.209275814464;40037.59962400375;40121;40155.39766903499;40271.395929061015;8463.195996380335;8698.608562614698;8714;8725.95637021814;8731.170538798804;8678.088800675932;8858.158474944903;8863.113688631118;8865.556722163867;8870.42342247755;8878.378513504058;8962.058983806704;8987.0563590823;8989.280857531414;8990.325725570576;8783.47299162049;8867.911320886773;8876.644934202624;8884.978227503856;8888.288936885034;8754.69358572447;8900.465972041633;8909.73270801877;8913.420627659181;8917.0637083106;40604;41076.1784764306;41189.38215926763;41210.38184427236;41217.1756564867;3195.344954284366;3275.21394865233;3325.451300535409;3731.626837316274;3738.700903927679;30182.69817301821;30233.546496802566;30403.391932161234;30415.239619009702;31620.209494762585;3912.9804350978347;4038.697097717683;4127.09203975125;4159.313713237312;4166.812493437803;265412;265857;266507;266602;266835;58330.70834645884;58441.41558584445;58580.41419585835;58633.70683146557;58660.706696467096;63030;63065;63096.68451657712;63235;63253.68373158105;13791.310434478237;14200.502982395567;14213.43146274158;14213.715725685428;14217.715645687029;10554;10595.470226488645;10611.204159688054;10615.150787936947;10630.362178269328;19199.65602407818;20014.799852001586;20064.79611223302;20147.697784533244;20162.89918550398;7574.431917606202;7585.734499292608;7594.582297973665;7635.465517413728;7708;936.0966667166217;978;985.5170966226498;1066.3761699405934;1139.9943000285111;27326.863365683046;28048.298792529942;28606.14181574556;28659.2835179118;28689;867.7613656244457;1041.8072656558409;1052.6684094510358;1085.766560189563;1153.7577108807245;14087.084339517898;14100.576982690536;14198.929005355114;14572.927135364256;14686;306920;309130;310370;310562;310892;44041.77979110084;50344.496555033984;51240.74379628078;51282.23076653853;51339.743301283255;1196.6649338185323;1270.0665011216747;1280.6606249343931;1331.1480652382677;1333.6665833541615;26712;27712.44575108527;27951.968645643166;28434.85782571074;28576.57135143016;43769.562304377825;44057.11885762331;44328;44376.55623443853;44430.55569444264;229897;231730;231911;232021;232236;26678.59982100309;27439.725602743718;30797.076087717403;31315;31334.686653133176;36666.250031248295;36797.26405471929;37700.43449348207;38185.6181438182;41050;34609.30781384308;34754;34870.65129348674;35265.82367088148;35898.10254743652;35005;35472.46791298184;35750.642493575775;36188.09529761777;36196.638033619325;31622;34601.48097778585;34903.30193396169;34939.82530087333;34953.65046349504;29563.704362956094;31120.844395778782;31824;32185.67814321827;32193.517097243093;24518;24736.381590460383;25047.87476062608;25171;26088.34779130461 20:10:44 INFO - PROCESS | 2460 | |2;jquery.html;350.07056265614796;350.70365541117746;354.3479996805877;357.21234677536034;361.75581482499325;13731.352237731462;14159.858401416008;16140.757888631666;16808.91595542022;17270.913645431756;15656.608584785386;15671.686566268669;16262.51212463628;16271.918640406782;16289.755653665205;5059.16523773577;5195.922061169066;5346.438623944488;5347.919781203285;5349.973250133744;3972.1062760878717;5323.041852466555;5662.263905692274;5806.82579522615;5855.941440585582;5663.9433605664035;5722.570807189478;5798.62308949919;5846.766129354821;5847.386024467433;5819.7672093116435;5855.063189889597;5865.03226967552;5874.588778785486;5875.324337701155;5088.618353623456;5134.127198376285;5203.531682148625;5215.608829337777;5216.165413533817;20006.69989950152;20131.798682013286;20261.29085482001;20279.290224842207;20309.695354569692;1997.530580313625;2019.7879222681702;2022.2315520102268;2066.555690526544;2157.611629906616;12189.756204875854;12502.437390317458;12713;12963.092583519157;13006.414711337919;1799.2173404569055;1838.9632207355912;1888.5278680329918;1893.479293194369;1899.202335019295;57052.429475705125;57519.712401437726;58186.709066454394;58960.70519647417;59076.40923590752;9468.857967130498;9779.853302200472;9788.902110978941;9796.9020309796;9823.901760982442;12669.49322027127;12676.429560669607;12758.298293593756;12784.488620455264;12789.552365667158;6721.630310332978;6722.361375669304;6723.495737819585;6759;6768.153980752406;6275.529335299871;6316.526260530479;6341.904871426932;6378.266499352634;6395.6482393468805;5158.143068495338;5792.565557583198;5862.589618726648;5875;5958.255218097738;1591.5145880506557;1596.066301213803;1636.885418020727;1713.7600735896985;1765.9117044147997;864.6152462154407;903.5662881816764;918.7151982885327;927.3925578745932;1112.165875593305;15865.762013569805;16606.75089873653;16717.164141793106;16814;16841.410550630913;897.6050537763493;961.2214106573698;981.7153025622489;1007.1791489935679;1022.3610243597751;9063.184313411824;9425.952870235606;9946.552405141785;9948.900510994943;9998.700038998843;520697;524073;524654;527639;538268;68968.31031689618;69328.30671693219;71887.64056179686;71969.2803071973;72491.63754181196;1136.1195073817858;1149.4827327702567;1155.2548606148987;1157.346099453806;1166.988330116705;15056.623584410478;15475.369187237971;15581.220938953235;15697.843021569639;15707.607309817346;32992.67007329896;33719.49420758642;33762.15594610056;34593.30813383769;34826;46057.30914036359;46179;46232.53767462282;47485;47758.522414775405;7429.368503677248;7555.8866616999685;7647.388208943383;7665.578393188205;7674;10996.670099897015;11414.543418263176;11531.135164862837;11532.88467115318;11700.302150660029;7810.82335560955;8246.257836794477;9496.958153996924;9806.264530160124;9806.313558051153;9376.95311523438;9678;9879.802403952024;10031.598736050477;10276.691699249035;7363.668634911334;9345.766355841159;9457.952710236405;9471.810563788547;9617.374870633386;7310.890336645061;7328.3770879473705;7414.962925185555;7458.925410745823;7508;9187.954060229924;9509.572069257038;9655.855162172433;9802.803943921224;9853.261005424478 20:10:44 INFO - PROCESS | 2460 | |3;mootools.html;1316.6313432238976;1466.5380405172366;1470.9632259193522;1628.6335574495733;1769.964600707985;6814.42077423419;7487.213842546529;7637.427192960537;7645.655945482453;7657.23427657234;7538.472306938516;7738.458307918434;7748.651310691018;7753.069631644211;7758.844823103549;1976.7331410259574;2190.9780902191014;2230.587341341849;2278.601244782165;2304;2226.510167763098;2233.55328934213;2242.7308722953267;2245.955080898381;2248.516568937678;2143.431990522513;2258.6837842701952;2269.3986093685185;2275.590393729128;2282.326713619478;2238.630625946717;2240.798328150466;2258.762829902861;2281.2243837095466;2287.2452090809993;2250.2574150530286;2273.0566814772014;2280.3273034454874;2280.680704701343;2289.2216646340325;7684.462087653867;7723;7732.806679832993;7741.961290193569;7753.534787912743;4513.345564893105;4656.278276867091;4657.278121891112;4658.440987081538;4660.13787449323;2934.105097945126;2958.3343747656604;3014.291641464254;3016.3213277012715;3061.540768884663;960.2126256469697;974.0648976982105;978.4178413843752;1007.269729446153;1018.0989824005734;10396.324238924446;10406.739831504197;10418.114460270886;10419.270651054429;10422.687319380355;4099.385092236188;4161.583841615814;4173.874783756492;4200.789960501963;4211.915761684749;8983.146601072887;9005.324600654978;9021;9027.729168124966;9032.819343613091;4693.7653117344;4696.7416792076765;4697.929531057037;4699.224627936421;4702.717836929795;4234;4268.658507319407;4272.359146128106;4276.978615106905;4279.828806847691;3341.565596472443;3568.518250036264;3574.767640103385;3661.6521430464063;3672.0452682302794;1090.9890901090887;1133.21241736992;1134.0927258193576;1145.68493664243;1154.7170943118822;1000.1298869983161;1014.8883622801486;1017.013496907998;1111.2721167635211;1308.3065975033248;7336.926630733731;7372.483926125227;7409.407247420193;7413.443991700644;7428.405727541784;1102.1733699725205;1107.7673688525338;1121.9439028048728;1130.8360287758228;1147.6384938744268;5538.75075621598;5573.60984731073;5631.887362252814;5632.408597097246;5632.971835140798;9309.813803724022;9698.660546880825;9719.805603887882;9807.362521436084;9836.311458197857;9659.71020869375;9675.661351852652;9677.661281855102;9684.903150968401;9690.70927872165;7263.382612477999;7421.517601355895;7452.441066920002;7454.4781865268915;7476.439267054884;7253.8186545336785;7261.745838895613;7304.598247096461;7319.670614822239;7323.450741194538;8479.788005299917;8583.27042201395;8649.481031138152;8795.164459376349;8813.250873675554;8852.070532594242;8893.199612034688;9005.684801031932;9016.594253258489;9049.728508144502;7014.088168538057;7075.964620176866;7078.398336141486;7086.220515743161;7100.573965561876;6813.2846051163915;7314.670839812327;7543.170251272246;7558.811029724081;7568.470207085451;6733.293004234485;6807.625580593115;6954.860902782018;6988.056612357267;7020.333068358498;6806.353396427331;6985.009272357353;7020.824479387852;7059.399951004017;7192.136943566806;7131.893021604784;7161.57030578167;7241.203467618663;7249.601271930094;7272.89090663651;6394.232692076795;6403.935960640334;6440.967795160994;6455.386738259858;6455.709493072729;6694.129763130762;6725.596464212163;6728;6737.562058466184;6750.932490675227 20:10:44 INFO - PROCESS | 2460 | |4;prototype.html;311.3570476965067;323.35490696061356;328.7600051962067;340.6355199936069;348.29991716649545;5691.573132015094;5815.273090863637;5816.418358164186;5816.505597024253;5861.76552937883;5595.076812325961;5692.77228910843;5750;5756.222909907172;5780.248567686195;4428.82284708612;4429.13631841791;4433.911321773563;4439.911201775963;4445.110977804436;4226.429432026668;4356.847510337139;4438.556144385551;4466.955330446686;4469.486009108945;4432.601065904068;4438.090191510732;4439.556044395551;4440.333949907524;4447.510773814878;4442.73343599385;4457.977710111461;4459.197344477992;4465.799039043251;4472.508024117377;3932.921341573181;3937.7243592948507;3948.1511475033008;3952.7825969571663;3955.48578684772;5349.572034237291;5472.069748142825;5485.259489968843;5505.449455054462;5509.641873278224;5162.096633089194;5176.0683077046115;5178.715170665612;5182.326297581328;5197.220416937452;6097.634141951453;6100.23747031621;6101.60339577926;6109.847253818646;6124.540659450515;4310.870673879757;4336.089421221547;4340.74118505633;4344.152890186415;4352.630026447756;6081.817545473643;6269.968650156766;6271.560990730651;6339.175907132089;6397.360263973612;4332.501762297313;4341.6743744218675;4358.193734159191;4361;4366.083122544302;4389.868303950887;4415.381846541487;4418.624416924533;4423.20382331177;4439.511653718088;4983.750812459435;5063.670861394071;5089.592832573385;5090.109230884655;5091.439941606421;6163.167972323679;6170.444659980623;6177.62934223939;6207.96896015517;6219.564630475823;1558.9454369097027;1590.8727301815827;1593.442295196695;1595.4336210645286;1596.6567188054623;1051.9000694933968;1058.111186603257;1062.3360399750156;1064.526285802826;1067.2902519824386;5810.50610698087;5816.272965879265;5820.097884827774;5823.679697616587;5826.82519524415;6235.844103897439;6277.591956522811;6283.96858015707;6290.811275661646;6293.905591416133;5800.9129863052085;5806.593538452352;5811.186433899257;5812.651240925558;5819.505342045889;3286.145602143412;3406.386850366958;3409.5397121388296;3409.7783644063056;3415.7438192135687;6511.576747511396;6532.379423954717;6550.344965503412;6552.246491653521;6565.80302590923;6456.322086180978;6457.3865482779065;6466.256380516207;6466.418022378009;6470.450011749054;6498.480121590262;6552.213734351908;6606.669666516655;6623.437007854386;6623.801285961429;6336.683165841781;6348.523860710373;6349.587276826992;6350.555461117678;6361.2048493938255;6057.697115144313;6250.499960003098;6287.842803929939;6291.6539590321145;6291.779787707408;6496.512761542808;6548.410643041959;6579.144711187515;6609.867802644017;6623.503237257321;4274.337477690963;4352.107817897387;4364.890877728082;4366.672499562482;4370.759608221579;6338.080978258219;6342.61944283326;6345.016522439029;6355.586886852339;6359.936400636119;6034.969825151022;6173.938260617337;6184.350643182581;6184.381561843779;6191.380861913773;6177.104319873503;6179.382061793965;6179.443850053517;6182.629042257479;6185.041318595625;6008.158857760004;6044.063170208625;6045.063015232646;6047.062705280513;6063.696815159313;6046.183765191643;6160.753569857335;6209.751609935552;6220.720067596879;6224.439800417984;6064.514838812973;6068.21113255274;6075.30134034574;6075.969620151871;6077.939220607737 20:10:44 INFO - PROCESS | 2460 | |5;yui.html;707.3492387003956;709.5458906299967;776.741678480861;788.5426452657459;833.9874901876473;13510.324483775808;13659.86340136597;13687.520936767216;13705.3832577534;13739.931300343496;12550.81173782394;13376.531821386254;13388.263645499517;13388.933055334734;13394.06241563091;675.4663815585706;683.9247682754893;685.1298850459913;784.1726978038154;826.6734639817269;679.9936094580024;819;833.9374546908975;839.3369238301765;840.2060053249681;871.5293741379679;882.1311008656468;882.7528292078197;883.5802993578063;884.1423818895661;699.2448155991542;846.255295340103;870.7648934787635;874.995625021874;876.7545087375545;643.9001954697029;648.0085469232082;648.4229036157823;648.9935100649028;649.3149727037973;13591.59225223235;13814.516491922835;13819.447222111205;13832.170069795844;13839.584812455643;13047.934760326138;13356.332183390792;13414.46342146313;13573.389197486136;13734.519291824738;10614.416207108607;10635.308704934232;10643.78712425755;10669.306495077873;10710.571577136905;3452.9654703452893;3587.0852932502307;3656.8720094796554;3745.962540374616;3758.2107757370986;46160.76919615414;46192.53807461949;46227;46230.537694623294;47853.28220076737;10047.492876068649;10231.48842557884;10292.639757608447;10377.84433233502;10380.32527885685;18237.7264341035;18478.076096195404;18506.537336566693;18515.444536663923;18527.907360463112;8058.234467725674;8058.838823223503;8081.838363232702;8142.633581488847;8299.83400332002;4535.047639995638;4551.3173024046;4554.407926969539;4565.429321334833;4626.21354369758;3117.0492999634876;3122.500399935999;3128.7340576050833;3137.027521468352;3148.2601588626653;551.589066145724;554.0441249478725;563.0653115827706;566.8781212039349;582.1239035251918;663.3234101216732;664.4717449627558;668.7224801707334;672.5930811858852;705.8200158959432;8613.181747733955;8625.39622226438;8626.396152269406;8821.144480317656;8856.512891790884;580.3181262017113;663.8705452436728;682.5836687379633;690.4821383962028;695.3776370148688;3991.6207960243732;4334.284843000933;4395.780210989502;4481.305397663367;4504.144212599595;54130.45869541333;55397.72301138549;55434;55631.443685563434;56006.43993560012;48230.27654585184;49110.50889491059;49125;49408;49783.25325120126;43811;44140.99999999936;44222.33666495005;44241;44601.10797784026;7911.851331349943;8226.588670566567;8242.134575869688;8244.29923456513;8445.40882138269;32533;33140.502892457116;33522.32955340831;33594.32811343808;33611.327773444886;38608;41625.79187104045;42245.36631950585;42745.57254427416;43059.56940430681;10284.691459256233;10496.002879726413;10655.627053053106;11160.162987775788;11404.372759498307;11942.820857687315;11973.161878668758;11990.700232494257;12163.574274900337;12167.330796805907;11159.609413670483;11440;11448.969592736694;11499;11663.88336116662;11132.88867111351;11189.216754827085;11427.60003399877;11466.770664586495;11632;10910.727231819268;11137.164712646421;11221.831672525082;11328.773424531299;11598.130140239684;8955.327966844581;8989.46063236208;9106;9120.978050563655;9241.399309044891;8299.751007469786;9042.593083311136;9377.765555861159;9422.528873556157;9491.905080949102 20:10:44 INFO - PROCESS | 2460 | __end_tp_report 20:10:44 INFO - PROCESS | 2460 | __start_cc_report 20:10:44 INFO - PROCESS | 2460 | _x_x_mozilla_cycle_collect,740 20:10:44 INFO - PROCESS | 2460 | __end_cc_report 20:10:44 INFO - PROCESS | 2460 | __startTimestamp1455595844165__endTimestamp 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | ------- Summary: start ------- 20:10:44 INFO - PROCESS | 2460 | Number of tests: 6 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | [#0] dojo.html Cycles:165 Average:5117.01 Median:5294.60 stddev:543.45 (10.3%) stddev-sans-first:522.59 20:10:44 INFO - PROCESS | 2460 | Values: 3142.8 3152.8 3187.1 3187.5 3217.5 4972.4 5099.4 5110.0 5116.1 5116.2 5022.6 5123.1 5182.3 5200.6 5216.7 4640.2 4660.0 4668.8 4673.0 4760.0 4659.6 4797.8 4811.1 4837.8 4883.7 4564.7 4642.3 4661.0 4766.8 4806.5 4651.4 4680.8 4685.3 4685.5 4686.3 4631.2 4653.1 4654.3 4654.3 4660.9 4897.7 4947.2 4971.2 4992.0 5008.4 5470.9 5473.6 5480.5 5481.9 5485.6 5391.2 5420.0 5503.8 5549.9 5567.3 5176.3 5208.7 5213.6 5216.3 5252.0 5568.1 5586.0 5607.7 5610.2 5613.9 5355.6 5412.8 5424.4 5428.8 5435.3 5502.0 5507.1 5511.1 5522.8 5542.1 5468.4 5475.9 5502.4 5503.3 5554.8 5418.8 5499.7 5501.7 5512.1 5591.3 4305.6 4305.9 4314.5 4315.4 4340.5 3851.9 3860.3 3877.2 3890.5 3895.4 4995.2 5072.6 5077.2 5127.4 5164.7 5525.1 5539.4 5549.5 5573.3 5575.5 5041.8 5129.4 5146.9 5162.5 5204.6 4635.0 4733.7 4787.5 4799.7 4813.2 5676.5 5683.4 5686.6 5688.0 5688.2 5422.8 5472.4 5483.1 5487.6 5543.2 5567.9 5664.6 5808.3 5858.8 5911.6 5445.7 5449.8 5450.4 5452.3 5453.9 5415.2 5503.6 5511.1 5526.3 5565.0 5310.9 5325.9 5330.7 5333.0 5377.7 5310.4 5359.4 5368.2 5392.2 5437.4 5233.9 5287.8 5294.6 5300.1 5328.9 5349.4 5377.5 5396.2 5433.0 5460.0 5273.6 5274.1 5277.3 5278.5 5280.0 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | [#1] ext.html Cycles:180 Average:43749.02 Median:35369.15 stddev:70749.84 (200.0%) stddev-sans-first:70873.82 20:10:44 INFO - PROCESS | 2460 | Values: 510.5 529.7 563.0 568.2 586.6 28194.2 28736.6 35902.8 36015.5 36020.5 39536.2 40037.6 40121.0 40155.4 40271.4 8463.2 8698.6 8714.0 8726.0 8731.2 8678.1 8858.2 8863.1 8865.6 8870.4 8878.4 8962.1 8987.1 8989.3 8990.3 8783.5 8867.9 8876.6 8885.0 8888.3 8754.7 8900.5 8909.7 8913.4 8917.1 40604.0 41076.2 41189.4 41210.4 41217.2 3195.3 3275.2 3325.5 3731.6 3738.7 30182.7 30233.5 30403.4 30415.2 31620.2 3913.0 4038.7 4127.1 4159.3 4166.8 265412.0 265857.0 266507.0 266602.0 266835.0 58330.7 58441.4 58580.4 58633.7 58660.7 63030.0 63065.0 63096.7 63235.0 63253.7 13791.3 14200.5 14213.4 14213.7 14217.7 10554.0 10595.5 10611.2 10615.2 10630.4 19199.7 20014.8 20064.8 20147.7 20162.9 7574.4 7585.7 7594.6 7635.5 7708.0 936.1 978.0 985.5 1066.4 1140.0 27326.9 28048.3 28606.1 28659.3 28689.0 867.8 1041.8 1052.7 1085.8 1153.8 14087.1 14100.6 14198.9 14572.9 14686.0 306920.0 309130.0 310370.0 310562.0 310892.0 44041.8 50344.5 51240.7 51282.2 51339.7 1196.7 1270.1 1280.7 1331.1 1333.7 26712.0 27712.4 27952.0 28434.9 28576.6 43769.6 44057.1 44328.0 44376.6 44430.6 229897.0 231730.0 231911.0 232021.0 232236.0 26678.6 27439.7 30797.1 31315.0 31334.7 36666.3 36797.3 37700.4 38185.6 41050.0 34609.3 34754.0 34870.7 35265.8 35898.1 35005.0 35472.5 35750.6 36188.1 36196.6 31622.0 34601.5 34903.3 34939.8 34953.7 29563.7 31120.8 31824.0 32185.7 32193.5 24518.0 24736.4 25047.9 25171.0 26088.3 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | [#2] jquery.html Cycles:180 Average:27355.29 Median:524363.50 stddev:86112.64 (16.4%) stddev-sans-first:86330.34 20:10:44 INFO - PROCESS | 2460 | Values: 350.1 350.7 354.3 357.2 361.8 13731.4 14159.9 16140.8 16808.9 17270.9 15656.6 15671.7 16262.5 16271.9 16289.8 5059.2 5195.9 5346.4 5347.9 5350.0 3972.1 5323.0 5662.3 5806.8 5855.9 5663.9 5722.6 5798.6 5846.8 5847.4 5819.8 5855.1 5865.0 5874.6 5875.3 5088.6 5134.1 5203.5 5215.6 5216.2 20006.7 20131.8 20261.3 20279.3 20309.7 1997.5 2019.8 2022.2 2066.6 2157.6 12189.8 12502.4 12713.0 12963.1 13006.4 1799.2 1839.0 1888.5 1893.5 1899.2 57052.4 57519.7 58186.7 58960.7 59076.4 9468.9 9779.9 9788.9 9796.9 9823.9 12669.5 12676.4 12758.3 12784.5 12789.6 6721.6 6722.4 6723.5 6759.0 6768.2 6275.5 6316.5 6341.9 6378.3 6395.6 5158.1 5792.6 5862.6 5875.0 5958.3 1591.5 1596.1 1636.9 1713.8 1765.9 864.6 903.6 918.7 927.4 1112.2 15865.8 16606.8 16717.2 16814.0 16841.4 897.6 961.2 981.7 1007.2 1022.4 9063.2 9426.0 9946.6 9948.9 9998.7 520697.0 524073.0 524654.0 527639.0 538268.0 68968.3 69328.3 71887.6 71969.3 72491.6 1136.1 1149.5 1155.3 1157.3 1167.0 15056.6 15475.4 15581.2 15697.8 15707.6 32992.7 33719.5 33762.2 34593.3 34826.0 46057.3 46179.0 46232.5 47485.0 47758.5 7429.4 7555.9 7647.4 7665.6 7674.0 10996.7 11414.5 11531.1 11532.9 11700.3 7810.8 8246.3 9497.0 9806.3 9806.3 9377.0 9678.0 9879.8 10031.6 10276.7 7363.7 9345.8 9458.0 9471.8 9617.4 7310.9 7328.4 7415.0 7458.9 7508.0 9188.0 9509.6 9655.9 9802.8 9853.3 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | [#3] mootools.html Cycles:180 Average:5475.18 Median:6455.55 stddev:2869.80 (44.5%) stddev-sans-first:2860.82 20:10:44 INFO - PROCESS | 2460 | Values: 1316.6 1466.5 1471.0 1628.6 1770.0 6814.4 7487.2 7637.4 7645.7 7657.2 7538.5 7738.5 7748.7 7753.1 7758.8 1976.7 2191.0 2230.6 2278.6 2304.0 2226.5 2233.6 2242.7 2246.0 2248.5 2143.4 2258.7 2269.4 2275.6 2282.3 2238.6 2240.8 2258.8 2281.2 2287.2 2250.3 2273.1 2280.3 2280.7 2289.2 7684.5 7723.0 7732.8 7742.0 7753.5 4513.3 4656.3 4657.3 4658.4 4660.1 2934.1 2958.3 3014.3 3016.3 3061.5 960.2 974.1 978.4 1007.3 1018.1 10396.3 10406.7 10418.1 10419.3 10422.7 4099.4 4161.6 4173.9 4200.8 4211.9 8983.1 9005.3 9021.0 9027.7 9032.8 4693.8 4696.7 4697.9 4699.2 4702.7 4234.0 4268.7 4272.4 4277.0 4279.8 3341.6 3568.5 3574.8 3661.7 3672.0 1091.0 1133.2 1134.1 1145.7 1154.7 1000.1 1014.9 1017.0 1111.3 1308.3 7336.9 7372.5 7409.4 7413.4 7428.4 1102.2 1107.8 1121.9 1130.8 1147.6 5538.8 5573.6 5631.9 5632.4 5633.0 9309.8 9698.7 9719.8 9807.4 9836.3 9659.7 9675.7 9677.7 9684.9 9690.7 7263.4 7421.5 7452.4 7454.5 7476.4 7253.8 7261.7 7304.6 7319.7 7323.5 8479.8 8583.3 8649.5 8795.2 8813.3 8852.1 8893.2 9005.7 9016.6 9049.7 7014.1 7076.0 7078.4 7086.2 7100.6 6813.3 7314.7 7543.2 7558.8 7568.5 6733.3 6807.6 6954.9 6988.1 7020.3 6806.4 6985.0 7020.8 7059.4 7192.1 7131.9 7161.6 7241.2 7249.6 7272.9 6394.2 6403.9 6441.0 6455.4 6455.7 6694.1 6725.6 6728.0 6737.6 6750.9 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | [#4] prototype.html Cycles:180 Average:5135.98 Median:5813.96 stddev:1537.33 (26.4%) stddev-sans-first:1498.39 20:10:44 INFO - PROCESS | 2460 | Values: 311.4 323.4 328.8 340.6 348.3 5691.6 5815.3 5816.4 5816.5 5861.8 5595.1 5692.8 5750.0 5756.2 5780.2 4428.8 4429.1 4433.9 4439.9 4445.1 4226.4 4356.8 4438.6 4467.0 4469.5 4432.6 4438.1 4439.6 4440.3 4447.5 4442.7 4458.0 4459.2 4465.8 4472.5 3932.9 3937.7 3948.2 3952.8 3955.5 5349.6 5472.1 5485.3 5505.4 5509.6 5162.1 5176.1 5178.7 5182.3 5197.2 6097.6 6100.2 6101.6 6109.8 6124.5 4310.9 4336.1 4340.7 4344.2 4352.6 6081.8 6270.0 6271.6 6339.2 6397.4 4332.5 4341.7 4358.2 4361.0 4366.1 4389.9 4415.4 4418.6 4423.2 4439.5 4983.8 5063.7 5089.6 5090.1 5091.4 6163.2 6170.4 6177.6 6208.0 6219.6 1558.9 1590.9 1593.4 1595.4 1596.7 1051.9 1058.1 1062.3 1064.5 1067.3 5810.5 5816.3 5820.1 5823.7 5826.8 6235.8 6277.6 6284.0 6290.8 6293.9 5800.9 5806.6 5811.2 5812.7 5819.5 3286.1 3406.4 3409.5 3409.8 3415.7 6511.6 6532.4 6550.3 6552.2 6565.8 6456.3 6457.4 6466.3 6466.4 6470.5 6498.5 6552.2 6606.7 6623.4 6623.8 6336.7 6348.5 6349.6 6350.6 6361.2 6057.7 6250.5 6287.8 6291.7 6291.8 6496.5 6548.4 6579.1 6609.9 6623.5 4274.3 4352.1 4364.9 4366.7 4370.8 6338.1 6342.6 6345.0 6355.6 6359.9 6035.0 6173.9 6184.4 6184.4 6191.4 6177.1 6179.4 6179.4 6182.6 6185.0 6008.2 6044.1 6045.1 6047.1 6063.7 6046.2 6160.8 6209.8 6220.7 6224.4 6064.5 6068.2 6075.3 6076.0 6077.9 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - PROCESS | 2460 | [#5] yui.html Cycles:180 Average:13499.50 Median:4543.18 stddev:15191.99 (334.4%) stddev-sans-first:15204.24 20:10:44 INFO - PROCESS | 2460 | Values: 707.3 709.5 776.7 788.5 834.0 13510.3 13659.9 13687.5 13705.4 13739.9 12550.8 13376.5 13388.3 13388.9 13394.1 675.5 683.9 685.1 784.2 826.7 680.0 819.0 833.9 839.3 840.2 871.5 882.1 882.8 883.6 884.1 699.2 846.3 870.8 875.0 876.8 643.9 648.0 648.4 649.0 649.3 13591.6 13814.5 13819.4 13832.2 13839.6 13047.9 13356.3 13414.5 13573.4 13734.5 10614.4 10635.3 10643.8 10669.3 10710.6 3453.0 3587.1 3656.9 3746.0 3758.2 46160.8 46192.5 46227.0 46230.5 47853.3 10047.5 10231.5 10292.6 10377.8 10380.3 18237.7 18478.1 18506.5 18515.4 18527.9 8058.2 8058.8 8081.8 8142.6 8299.8 4535.0 4551.3 4554.4 4565.4 4626.2 3117.0 3122.5 3128.7 3137.0 3148.3 551.6 554.0 563.1 566.9 582.1 663.3 664.5 668.7 672.6 705.8 8613.2 8625.4 8626.4 8821.1 8856.5 580.3 663.9 682.6 690.5 695.4 3991.6 4334.3 4395.8 4481.3 4504.1 54130.5 55397.7 55434.0 55631.4 56006.4 48230.3 49110.5 49125.0 49408.0 49783.3 43811.0 44141.0 44222.3 44241.0 44601.1 7911.9 8226.6 8242.1 8244.3 8445.4 32533.0 33140.5 33522.3 33594.3 33611.3 38608.0 41625.8 42245.4 42745.6 43059.6 10284.7 10496.0 10655.6 11160.2 11404.4 11942.8 11973.2 11990.7 12163.6 12167.3 11159.6 11440.0 11449.0 11499.0 11663.9 11132.9 11189.2 11427.6 11466.8 11632.0 10910.7 11137.2 11221.8 11328.8 11598.1 8955.3 8989.5 9106.0 9121.0 9241.4 8299.8 9042.6 9377.8 9422.5 9491.9 20:10:44 INFO - PROCESS | 2460 | -------- Summary: end -------- 20:10:44 INFO - PROCESS | 2460 | 20:10:44 INFO - TEST-INFO | 2460: exit 0 20:10:44 INFO - TEST-OK | dromaeo_css | took 1113751ms 20:10:44 INFO - TEST-START | kraken 20:10:44 INFO - operating with platform_type : linux_ 20:10:44 INFO - Initialising browser for kraken test... 20:10:44 INFO - TEST-INFO | started process 2660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFv1bN0/profile http://localhost:60300/getInfo.html) 20:10:49 INFO - PROCESS | 2660 | __metrics Screen width/height:1600/1200 20:10:49 INFO - PROCESS | 2660 | colorDepth:24 20:10:49 INFO - PROCESS | 2660 | Browser inner width/height: 1024/697 20:10:49 INFO - PROCESS | 2660 | __metrics 20:10:50 INFO - PROCESS | 2660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:11:20 INFO - TEST-INFO | 2660: exit 0 20:11:20 INFO - Browser initialized. 20:11:20 INFO - Running cycle 1/1 for kraken test... 20:11:20 INFO - TEST-INFO | started process 2797 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFv1bN0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:32 INFO - PROCESS | 2797 | RSS: Main: 148602880 20:11:32 INFO - PROCESS | 2797 | 20:11:34 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:35 INFO - PROCESS | 2797 | RSS: Main: 192131072 20:11:35 INFO - PROCESS | 2797 | 20:11:37 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-dft) 20:11:38 INFO - PROCESS | 2797 | RSS: Main: 181686272 20:11:38 INFO - PROCESS | 2797 | 20:11:41 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-fft) 20:11:41 INFO - PROCESS | 2797 | RSS: Main: 167038976 20:11:41 INFO - PROCESS | 2797 | 20:11:43 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-oscillator) 20:11:44 INFO - PROCESS | 2797 | RSS: Main: 167477248 20:11:44 INFO - PROCESS | 2797 | 20:11:46 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:47 INFO - PROCESS | 2797 | RSS: Main: 170336256 20:11:47 INFO - PROCESS | 2797 | 20:11:50 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:50 INFO - PROCESS | 2797 | RSS: Main: 170713088 20:11:50 INFO - PROCESS | 2797 | 20:11:54 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:54 INFO - PROCESS | 2797 | RSS: Main: 171720704 20:11:54 INFO - PROCESS | 2797 | 20:11:57 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60300/tests/kraken/driver.html?testName=json-parse-financial) 20:11:58 INFO - PROCESS | 2797 | RSS: Main: 170201088 20:11:58 INFO - PROCESS | 2797 | 20:11:59 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:12:00 INFO - PROCESS | 2797 | RSS: Main: 182198272 20:12:00 INFO - PROCESS | 2797 | 20:12:02 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:12:02 INFO - PROCESS | 2797 | RSS: Main: 179109888 20:12:02 INFO - PROCESS | 2797 | 20:12:04 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:12:05 INFO - PROCESS | 2797 | RSS: Main: 194101248 20:12:05 INFO - PROCESS | 2797 | 20:12:07 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:12:08 INFO - PROCESS | 2797 | RSS: Main: 199495680 20:12:08 INFO - PROCESS | 2797 | 20:12:11 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:12:11 INFO - PROCESS | 2797 | RSS: Main: 198111232 20:12:11 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60300/tests/kraken/driver.html?testName=ai-astar) 20:12:13 INFO - PROCESS | 2797 | RSS: Main: 260038656 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | __start_tp_report 20:12:13 INFO - PROCESS | 2797 | _x_x_mozilla_page_load 20:12:13 INFO - PROCESS | 2797 | _x_x_mozilla_page_load_details 20:12:13 INFO - PROCESS | 2797 | |i|pagename|runs| 20:12:13 INFO - PROCESS | 2797 | |0;ai-astar;111;112;108;111;112;113;102;115;112;111 20:12:13 INFO - PROCESS | 2797 | |1;audio-beat-detection;150;126;162;166;125;151;149;127;168;128 20:12:13 INFO - PROCESS | 2797 | |2;audio-dft;163;163;162;161;163;161;159;164;161;161 20:12:13 INFO - PROCESS | 2797 | |3;audio-fft;74;72;106;95;73;75;74;118;91;75 20:12:13 INFO - PROCESS | 2797 | |4;audio-oscillator;96;95;147;95;96;96;139;96;97;140 20:12:13 INFO - PROCESS | 2797 | |5;imaging-gaussian-blur;119;115;115;115;115;115;115;115;115;115 20:12:13 INFO - PROCESS | 2797 | |6;imaging-darkroom;145;145;147;146;145;146;145;145;146;145 20:12:13 INFO - PROCESS | 2797 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;96;95 20:12:13 INFO - PROCESS | 2797 | |8;json-parse-financial;57;56;56;55;55;56;57;66;55;55 20:12:13 INFO - PROCESS | 2797 | |9;json-stringify-tinderbox;66;66;66;67;67;67;67;66;67;67 20:12:13 INFO - PROCESS | 2797 | |10;stanford-crypto-aes;80;83;81;83;83;81;85;82;89;83 20:12:13 INFO - PROCESS | 2797 | |11;stanford-crypto-ccm;118;121;118;123;124;116;124;121;128;120 20:12:13 INFO - PROCESS | 2797 | |12;stanford-crypto-pbkdf2;159;140;153;150;143;142;163;150;148;144 20:12:13 INFO - PROCESS | 2797 | |13;stanford-crypto-sha256-iterative;70;71;72;73;72;69;70;70;72;68 20:12:13 INFO - PROCESS | 2797 | __end_tp_report 20:12:13 INFO - PROCESS | 2797 | __start_cc_report 20:12:13 INFO - PROCESS | 2797 | _x_x_mozilla_cycle_collect,973 20:12:13 INFO - PROCESS | 2797 | __end_cc_report 20:12:13 INFO - PROCESS | 2797 | __startTimestamp1455595933612__endTimestamp 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | ------- Summary: start ------- 20:12:13 INFO - PROCESS | 2797 | Number of tests: 14 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.53 (3.2%) stddev-sans-first:3.74 20:12:13 INFO - PROCESS | 2797 | Values: 111.0 112.0 108.0 111.0 112.0 113.0 102.0 115.0 112.0 111.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:150.50 stddev:17.35 (11.5%) stddev-sans-first:18.32 20:12:13 INFO - PROCESS | 2797 | Values: 150.0 126.0 162.0 166.0 125.0 151.0 149.0 127.0 168.0 128.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.48 (0.9%) stddev-sans-first:1.50 20:12:13 INFO - PROCESS | 2797 | Values: 163.0 163.0 162.0 161.0 163.0 161.0 159.0 164.0 161.0 161.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#3] audio-fft Cycles:10 Average:85.30 Median:74.50 stddev:16.40 (22.0%) stddev-sans-first:16.88 20:12:13 INFO - PROCESS | 2797 | Values: 74.0 72.0 106.0 95.0 73.0 75.0 74.0 118.0 91.0 75.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:22.39 (23.3%) stddev-sans-first:23.19 20:12:13 INFO - PROCESS | 2797 | Values: 96.0 95.0 147.0 95.0 96.0 96.0 139.0 96.0 97.0 140.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.26 (1.1%) stddev-sans-first:0.00 20:12:13 INFO - PROCESS | 2797 | Values: 119.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 20:12:13 INFO - PROCESS | 2797 | Values: 145.0 145.0 147.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 20:12:13 INFO - PROCESS | 2797 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:3.33 (5.9%) stddev-sans-first:3.53 20:12:13 INFO - PROCESS | 2797 | Values: 57.0 56.0 56.0 55.0 55.0 56.0 57.0 66.0 55.0 55.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 20:12:13 INFO - PROCESS | 2797 | Values: 66.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 67.0 67.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:2.54 (3.1%) stddev-sans-first:2.45 20:12:13 INFO - PROCESS | 2797 | Values: 80.0 83.0 81.0 83.0 83.0 81.0 85.0 82.0 89.0 83.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.00 stddev:3.56 (2.9%) stddev-sans-first:3.57 20:12:13 INFO - PROCESS | 2797 | Values: 118.0 121.0 118.0 123.0 124.0 116.0 124.0 121.0 128.0 120.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:150.00 stddev:7.50 (5.0%) stddev-sans-first:7.06 20:12:13 INFO - PROCESS | 2797 | Values: 159.0 140.0 153.0 150.0 143.0 142.0 163.0 150.0 148.0 144.0 20:12:13 INFO - PROCESS | 2797 | 20:12:13 INFO - PROCESS | 2797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.50 stddev:1.57 (2.2%) stddev-sans-first:1.64 20:12:13 INFO - PROCESS | 2797 | Values: 70.0 71.0 72.0 73.0 72.0 69.0 70.0 70.0 72.0 68.0 20:12:13 INFO - PROCESS | 2797 | -------- Summary: end -------- 20:12:13 INFO - PROCESS | 2797 | 20:12:14 INFO - TEST-INFO | 2797: exit 0 20:12:14 INFO - TEST-OK | kraken | took 89662ms 20:12:14 INFO - SUITE-END | took 1203s 20:12:14 INFO - Completed test suite (00:20:03) 20:12:14 INFO - Working with test: dromaeo_css 20:12:14 INFO - Generating results file: dromaeo_css 20:12:14 INFO - Working with test: kraken 20:12:14 INFO - Generating results file: kraken 20:12:14 INFO - javascript benchmark 20:12:14 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:12:14 INFO - process_Request line: dromaeo_css 6794.96 graph.html#tests=[[72,64,35]] 20:12:14 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:14 INFO - process_Request line: kraken 1517.20 graph.html#tests=[[232,64,35]] 20:12:14 INFO - RETURN: dromaeo_css: 6794.96 20:12:14 INFO - RETURN: kraken: 1517.20 20:12:14 INFO - javascript benchmark 20:12:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3142.842857857107, 3152.7950683205604, 3187.107609869236, 3187.5378070179822, 3217.4530329843924, 4972.428170760355, 5099.439061703214, 5110.0, 5116.104681680705, 5116.155834287338, 5022.598192144629, 5123.052235336465, 5182.274481572583, 5200.609954253437, 5216.66091704039, 4640.2343613303765, 4659.976700116495, 4668.813247470097, 4672.953270467303, 4760.047990401916, 4659.580637742602, 4797.808087676489, 4811.13399588074, 4837.782299796518, 4883.682560633565, 4564.726116433025, 4642.280446530793, 4661.0, 4766.7616619169075, 4806.543378379066, 4651.44182698075, 4680.789364478606, 4685.344051832746, 4685.461171965199, 4686.343911852344, 4631.2126938420215, 4653.092646933849, 4654.325122857201, 4654.348391225198, 4660.906781864343, 4897.657163998521, 4947.208446648555, 4971.204607262856, 4991.950080499185, 5008.398992120932, 5470.890582188334, 5473.616846820724, 5480.451954804527, 5481.890362192774, 5485.588580856412, 5391.218273350342, 5419.972900135514, 5503.752331145068, 5549.916751248735, 5567.331920169565, 5176.275321454999, 5208.661437006583, 5213.5829133669595, 5216.3218781558535, 5251.973740131313, 5568.109102543654, 5586.0, 5607.7476513556985, 5610.242617246619, 5613.915791263134, 5355.571554275649, 5412.78348866041, 5424.430434804368, 5428.7557059931605, 5435.320584926884, 5501.972490137524, 5507.146392309199, 5511.063119269734, 5522.834314970557, 5542.085555883315, 5468.425815289417, 5475.945240547623, 5502.422245664227, 5503.3120859892515, 5554.805581804699, 5418.810341638024, 5499.725013749377, 5501.697406642593, 5512.118061110284, 5591.30108736408, 4305.56944305567, 4305.91388172241, 4314.525402205755, 4315.3742707307265, 4340.457442819647, 3851.9422208666892, 3860.285847118292, 3877.166409222031, 3890.5331360236387, 3895.3962135868987, 4995.150824359795, 5072.594192464594, 5077.162268225775, 5127.435982041972, 5164.741762911839, 5525.11598144295, 5539.41836107211, 5549.500544950974, 5573.27547418833, 5575.470330318613, 5041.773120209599, 5129.384473863086, 5146.871328216825, 5162.535371816554, 5204.609654275944, 4635.026644404646, 4733.715977041388, 4787.497312782108, 4799.66402351839, 4813.181759100961, 5676.545876329967, 5683.403242659544, 5686.630369026, 5687.971560142173, 5688.175214593861, 5422.8373148805595, 5472.370677372153, 5483.122700367922, 5487.6158668892795, 5543.1962365455975, 5567.944320556742, 5664.575156863334, 5808.273965754281, 5858.794942177004, 5911.556633252438, 5445.700486473282, 5449.836504904859, 5450.400455949763, 5452.291202143696, 5453.945460545502, 5415.160650099241, 5503.587230957614, 5511.145772405283, 5526.281583394294, 5564.972175139098, 5310.946890531045, 5325.920111198413, 5330.70681112527, 5333.0, 5377.677339359651, 5310.442403547572, 5359.356877174764, 5368.22160786676, 5392.164214546751, 5437.429069947757, 5233.947660523346, 5287.841364759063, 5294.602904782234, 5300.098983172793, 5328.866778330573, 5349.411564727955, 5377.516023557899, 5396.244525766318, 5433.049216387038, 5460.0, 5273.578113750814, 5274.050670879278, 5277.340332458442, 5278.498542638443, 5279.973600131974], "unit": "score", "name": "dojo.html", "value": 5083.792028466649}, {"lowerIsBetter": false, "replicates": [510.53286243087575, 529.7218960045977, 562.9634073785204, 568.1789813719178, 586.630422833615, 28194.15417537472, 28736.568951465746, 35902.820485897566, 36015.4597681035, 36020.459693104625, 39536.209275814464, 40037.59962400375, 40121.0, 40155.39766903499, 40271.395929061015, 8463.195996380335, 8698.608562614698, 8714.0, 8725.95637021814, 8731.170538798804, 8678.088800675932, 8858.158474944903, 8863.113688631118, 8865.556722163867, 8870.42342247755, 8878.378513504058, 8962.058983806704, 8987.0563590823, 8989.280857531414, 8990.325725570576, 8783.47299162049, 8867.911320886773, 8876.644934202624, 8884.978227503856, 8888.288936885034, 8754.69358572447, 8900.465972041633, 8909.73270801877, 8913.420627659181, 8917.0637083106, 40604.0, 41076.1784764306, 41189.38215926763, 41210.38184427236, 41217.1756564867, 3195.344954284366, 3275.21394865233, 3325.451300535409, 3731.626837316274, 3738.700903927679, 30182.69817301821, 30233.546496802566, 30403.391932161234, 30415.239619009702, 31620.209494762585, 3912.9804350978347, 4038.697097717683, 4127.09203975125, 4159.313713237312, 4166.812493437803, 265412.0, 265857.0, 266507.0, 266602.0, 266835.0, 58330.70834645884, 58441.41558584445, 58580.41419585835, 58633.70683146557, 58660.706696467096, 63030.0, 63065.0, 63096.68451657712, 63235.0, 63253.68373158105, 13791.310434478237, 14200.502982395567, 14213.43146274158, 14213.715725685428, 14217.715645687029, 10554.0, 10595.470226488645, 10611.204159688054, 10615.150787936947, 10630.362178269328, 19199.65602407818, 20014.799852001586, 20064.79611223302, 20147.697784533244, 20162.89918550398, 7574.431917606202, 7585.734499292608, 7594.582297973665, 7635.465517413728, 7708.0, 936.0966667166217, 978.0, 985.5170966226498, 1066.3761699405934, 1139.9943000285111, 27326.863365683046, 28048.298792529942, 28606.14181574556, 28659.2835179118, 28689.0, 867.7613656244457, 1041.8072656558409, 1052.6684094510358, 1085.766560189563, 1153.7577108807245, 14087.084339517898, 14100.576982690536, 14198.929005355114, 14572.927135364256, 14686.0, 306920.0, 309130.0, 310370.0, 310562.0, 310892.0, 44041.77979110084, 50344.496555033984, 51240.74379628078, 51282.23076653853, 51339.743301283255, 1196.6649338185323, 1270.0665011216747, 1280.6606249343931, 1331.1480652382677, 1333.6665833541615, 26712.0, 27712.44575108527, 27951.968645643166, 28434.85782571074, 28576.57135143016, 43769.562304377825, 44057.11885762331, 44328.0, 44376.55623443853, 44430.55569444264, 229897.0, 231730.0, 231911.0, 232021.0, 232236.0, 26678.59982100309, 27439.725602743718, 30797.076087717403, 31315.0, 31334.686653133176, 36666.250031248295, 36797.26405471929, 37700.43449348207, 38185.6181438182, 41050.0, 34609.30781384308, 34754.0, 34870.65129348674, 35265.82367088148, 35898.10254743652, 35005.0, 35472.46791298184, 35750.642493575775, 36188.09529761777, 36196.638033619325, 31622.0, 34601.48097778585, 34903.30193396169, 34939.82530087333, 34953.65046349504, 29563.704362956094, 31120.844395778782, 31824.0, 32185.67814321827, 32193.517097243093, 24518.0, 24736.381590460383, 25047.87476062608, 25171.0, 26088.34779130461], "unit": "score", "name": "ext.html", "value": 17961.3870072065}, {"lowerIsBetter": false, "replicates": [350.07056265614796, 350.70365541117746, 354.3479996805877, 357.21234677536034, 361.75581482499325, 13731.352237731462, 14159.858401416008, 16140.757888631666, 16808.91595542022, 17270.913645431756, 15656.608584785386, 15671.686566268669, 16262.51212463628, 16271.918640406782, 16289.755653665205, 5059.16523773577, 5195.922061169066, 5346.438623944488, 5347.919781203285, 5349.973250133744, 3972.1062760878717, 5323.041852466555, 5662.263905692274, 5806.82579522615, 5855.941440585582, 5663.9433605664035, 5722.570807189478, 5798.62308949919, 5846.766129354821, 5847.386024467433, 5819.7672093116435, 5855.063189889597, 5865.03226967552, 5874.588778785486, 5875.324337701155, 5088.618353623456, 5134.127198376285, 5203.531682148625, 5215.608829337777, 5216.165413533817, 20006.69989950152, 20131.798682013286, 20261.29085482001, 20279.290224842207, 20309.695354569692, 1997.530580313625, 2019.7879222681702, 2022.2315520102268, 2066.555690526544, 2157.611629906616, 12189.756204875854, 12502.437390317458, 12713.0, 12963.092583519157, 13006.414711337919, 1799.2173404569055, 1838.9632207355912, 1888.5278680329918, 1893.479293194369, 1899.202335019295, 57052.429475705125, 57519.712401437726, 58186.709066454394, 58960.70519647417, 59076.40923590752, 9468.857967130498, 9779.853302200472, 9788.902110978941, 9796.9020309796, 9823.901760982442, 12669.49322027127, 12676.429560669607, 12758.298293593756, 12784.488620455264, 12789.552365667158, 6721.630310332978, 6722.361375669304, 6723.495737819585, 6759.0, 6768.153980752406, 6275.529335299871, 6316.526260530479, 6341.904871426932, 6378.266499352634, 6395.6482393468805, 5158.143068495338, 5792.565557583198, 5862.589618726648, 5875.0, 5958.255218097738, 1591.5145880506557, 1596.066301213803, 1636.885418020727, 1713.7600735896985, 1765.9117044147997, 864.6152462154407, 903.5662881816764, 918.7151982885327, 927.3925578745932, 1112.165875593305, 15865.762013569805, 16606.75089873653, 16717.164141793106, 16814.0, 16841.410550630913, 897.6050537763493, 961.2214106573698, 981.7153025622489, 1007.1791489935679, 1022.3610243597751, 9063.184313411824, 9425.952870235606, 9946.552405141785, 9948.900510994943, 9998.700038998843, 520697.0, 524073.0, 524654.0, 527639.0, 538268.0, 68968.31031689618, 69328.30671693219, 71887.64056179686, 71969.2803071973, 72491.63754181196, 1136.1195073817858, 1149.4827327702567, 1155.2548606148987, 1157.346099453806, 1166.988330116705, 15056.623584410478, 15475.369187237971, 15581.220938953235, 15697.843021569639, 15707.607309817346, 32992.67007329896, 33719.49420758642, 33762.15594610056, 34593.30813383769, 34826.0, 46057.30914036359, 46179.0, 46232.53767462282, 47485.0, 47758.522414775405, 7429.368503677248, 7555.8866616999685, 7647.388208943383, 7665.578393188205, 7674.0, 10996.670099897015, 11414.543418263176, 11531.135164862837, 11532.88467115318, 11700.302150660029, 7810.82335560955, 8246.257836794477, 9496.958153996924, 9806.264530160124, 9806.313558051153, 9376.95311523438, 9678.0, 9879.802403952024, 10031.598736050477, 10276.691699249035, 7363.668634911334, 9345.766355841159, 9457.952710236405, 9471.810563788547, 9617.374870633386, 7310.890336645061, 7328.3770879473705, 7414.962925185555, 7458.925410745823, 7508.0, 9187.954060229924, 9509.572069257038, 9655.855162172433, 9802.803943921224, 9853.261005424478], "unit": "score", "name": "jquery.html", "value": 8249.335085319415}, {"lowerIsBetter": false, "replicates": [1316.6313432238976, 1466.5380405172366, 1470.9632259193522, 1628.6335574495733, 1769.964600707985, 6814.42077423419, 7487.213842546529, 7637.427192960537, 7645.655945482453, 7657.23427657234, 7538.472306938516, 7738.458307918434, 7748.651310691018, 7753.069631644211, 7758.844823103549, 1976.7331410259574, 2190.9780902191014, 2230.587341341849, 2278.601244782165, 2304.0, 2226.510167763098, 2233.55328934213, 2242.7308722953267, 2245.955080898381, 2248.516568937678, 2143.431990522513, 2258.6837842701952, 2269.3986093685185, 2275.590393729128, 2282.326713619478, 2238.630625946717, 2240.798328150466, 2258.762829902861, 2281.2243837095466, 2287.2452090809993, 2250.2574150530286, 2273.0566814772014, 2280.3273034454874, 2280.680704701343, 2289.2216646340325, 7684.462087653867, 7723.0, 7732.806679832993, 7741.961290193569, 7753.534787912743, 4513.345564893105, 4656.278276867091, 4657.278121891112, 4658.440987081538, 4660.13787449323, 2934.105097945126, 2958.3343747656604, 3014.291641464254, 3016.3213277012715, 3061.540768884663, 960.2126256469697, 974.0648976982105, 978.4178413843752, 1007.269729446153, 1018.0989824005734, 10396.324238924446, 10406.739831504197, 10418.114460270886, 10419.270651054429, 10422.687319380355, 4099.385092236188, 4161.583841615814, 4173.874783756492, 4200.789960501963, 4211.915761684749, 8983.146601072887, 9005.324600654978, 9021.0, 9027.729168124966, 9032.819343613091, 4693.7653117344, 4696.7416792076765, 4697.929531057037, 4699.224627936421, 4702.717836929795, 4234.0, 4268.658507319407, 4272.359146128106, 4276.978615106905, 4279.828806847691, 3341.565596472443, 3568.518250036264, 3574.767640103385, 3661.6521430464063, 3672.0452682302794, 1090.9890901090887, 1133.21241736992, 1134.0927258193576, 1145.68493664243, 1154.7170943118822, 1000.1298869983161, 1014.8883622801486, 1017.013496907998, 1111.2721167635211, 1308.3065975033248, 7336.926630733731, 7372.483926125227, 7409.407247420193, 7413.443991700644, 7428.405727541784, 1102.1733699725205, 1107.7673688525338, 1121.9439028048728, 1130.8360287758228, 1147.6384938744268, 5538.75075621598, 5573.60984731073, 5631.887362252814, 5632.408597097246, 5632.971835140798, 9309.813803724022, 9698.660546880825, 9719.805603887882, 9807.362521436084, 9836.311458197857, 9659.71020869375, 9675.661351852652, 9677.661281855102, 9684.903150968401, 9690.70927872165, 7263.382612477999, 7421.517601355895, 7452.441066920002, 7454.4781865268915, 7476.439267054884, 7253.8186545336785, 7261.745838895613, 7304.598247096461, 7319.670614822239, 7323.450741194538, 8479.788005299917, 8583.27042201395, 8649.481031138152, 8795.164459376349, 8813.250873675554, 8852.070532594242, 8893.199612034688, 9005.684801031932, 9016.594253258489, 9049.728508144502, 7014.088168538057, 7075.964620176866, 7078.398336141486, 7086.220515743161, 7100.573965561876, 6813.2846051163915, 7314.670839812327, 7543.170251272246, 7558.811029724081, 7568.470207085451, 6733.293004234485, 6807.625580593115, 6954.860902782018, 6988.056612357267, 7020.333068358498, 6806.353396427331, 6985.009272357353, 7020.824479387852, 7059.399951004017, 7192.136943566806, 7131.893021604784, 7161.57030578167, 7241.203467618663, 7249.601271930094, 7272.89090663651, 6394.232692076795, 6403.935960640334, 6440.967795160994, 6455.386738259858, 6455.709493072729, 6694.129763130762, 6725.596464212163, 6728.0, 6737.562058466184, 6750.932490675227], "unit": "score", "name": "mootools.html", "value": 4472.224023505575}, {"lowerIsBetter": false, "replicates": [311.3570476965067, 323.35490696061356, 328.7600051962067, 340.6355199936069, 348.29991716649545, 5691.573132015094, 5815.273090863637, 5816.418358164186, 5816.505597024253, 5861.76552937883, 5595.076812325961, 5692.77228910843, 5750.0, 5756.222909907172, 5780.248567686195, 4428.82284708612, 4429.13631841791, 4433.911321773563, 4439.911201775963, 4445.110977804436, 4226.429432026668, 4356.847510337139, 4438.556144385551, 4466.955330446686, 4469.486009108945, 4432.601065904068, 4438.090191510732, 4439.556044395551, 4440.333949907524, 4447.510773814878, 4442.73343599385, 4457.977710111461, 4459.197344477992, 4465.799039043251, 4472.508024117377, 3932.921341573181, 3937.7243592948507, 3948.1511475033008, 3952.7825969571663, 3955.48578684772, 5349.572034237291, 5472.069748142825, 5485.259489968843, 5505.449455054462, 5509.641873278224, 5162.096633089194, 5176.0683077046115, 5178.715170665612, 5182.326297581328, 5197.220416937452, 6097.634141951453, 6100.23747031621, 6101.60339577926, 6109.847253818646, 6124.540659450515, 4310.870673879757, 4336.089421221547, 4340.74118505633, 4344.152890186415, 4352.630026447756, 6081.817545473643, 6269.968650156766, 6271.560990730651, 6339.175907132089, 6397.360263973612, 4332.501762297313, 4341.6743744218675, 4358.193734159191, 4361.0, 4366.083122544302, 4389.868303950887, 4415.381846541487, 4418.624416924533, 4423.20382331177, 4439.511653718088, 4983.750812459435, 5063.670861394071, 5089.592832573385, 5090.109230884655, 5091.439941606421, 6163.167972323679, 6170.444659980623, 6177.62934223939, 6207.96896015517, 6219.564630475823, 1558.9454369097027, 1590.8727301815827, 1593.442295196695, 1595.4336210645286, 1596.6567188054623, 1051.9000694933968, 1058.111186603257, 1062.3360399750156, 1064.526285802826, 1067.2902519824386, 5810.50610698087, 5816.272965879265, 5820.097884827774, 5823.679697616587, 5826.82519524415, 6235.844103897439, 6277.591956522811, 6283.96858015707, 6290.811275661646, 6293.905591416133, 5800.9129863052085, 5806.593538452352, 5811.186433899257, 5812.651240925558, 5819.505342045889, 3286.145602143412, 3406.386850366958, 3409.5397121388296, 3409.7783644063056, 3415.7438192135687, 6511.576747511396, 6532.379423954717, 6550.344965503412, 6552.246491653521, 6565.80302590923, 6456.322086180978, 6457.3865482779065, 6466.256380516207, 6466.418022378009, 6470.450011749054, 6498.480121590262, 6552.213734351908, 6606.669666516655, 6623.437007854386, 6623.801285961429, 6336.683165841781, 6348.523860710373, 6349.587276826992, 6350.555461117678, 6361.2048493938255, 6057.697115144313, 6250.499960003098, 6287.842803929939, 6291.6539590321145, 6291.779787707408, 6496.512761542808, 6548.410643041959, 6579.144711187515, 6609.867802644017, 6623.503237257321, 4274.337477690963, 4352.107817897387, 4364.890877728082, 4366.672499562482, 4370.759608221579, 6338.080978258219, 6342.61944283326, 6345.016522439029, 6355.586886852339, 6359.936400636119, 6034.969825151022, 6173.938260617337, 6184.350643182581, 6184.381561843779, 6191.380861913773, 6177.104319873503, 6179.382061793965, 6179.443850053517, 6182.629042257479, 6185.041318595625, 6008.158857760004, 6044.063170208625, 6045.063015232646, 6047.062705280513, 6063.696815159313, 6046.183765191643, 6160.753569857335, 6209.751609935552, 6220.720067596879, 6224.439800417984, 6064.514838812973, 6068.21113255274, 6075.30134034574, 6075.969620151871, 6077.939220607737], "unit": "score", "name": "prototype.html", "value": 4639.675055241528}, {"lowerIsBetter": false, "replicates": [707.3492387003956, 709.5458906299967, 776.741678480861, 788.5426452657459, 833.9874901876473, 13510.324483775808, 13659.86340136597, 13687.520936767216, 13705.3832577534, 13739.931300343496, 12550.81173782394, 13376.531821386254, 13388.263645499517, 13388.933055334734, 13394.06241563091, 675.4663815585706, 683.9247682754893, 685.1298850459913, 784.1726978038154, 826.6734639817269, 679.9936094580024, 819.0, 833.9374546908975, 839.3369238301765, 840.2060053249681, 871.5293741379679, 882.1311008656468, 882.7528292078197, 883.5802993578063, 884.1423818895661, 699.2448155991542, 846.255295340103, 870.7648934787635, 874.995625021874, 876.7545087375545, 643.9001954697029, 648.0085469232082, 648.4229036157823, 648.9935100649028, 649.3149727037973, 13591.59225223235, 13814.516491922835, 13819.447222111205, 13832.170069795844, 13839.584812455643, 13047.934760326138, 13356.332183390792, 13414.46342146313, 13573.389197486136, 13734.519291824738, 10614.416207108607, 10635.308704934232, 10643.78712425755, 10669.306495077873, 10710.571577136905, 3452.9654703452893, 3587.0852932502307, 3656.8720094796554, 3745.962540374616, 3758.2107757370986, 46160.76919615414, 46192.53807461949, 46227.0, 46230.537694623294, 47853.28220076737, 10047.492876068649, 10231.48842557884, 10292.639757608447, 10377.84433233502, 10380.32527885685, 18237.7264341035, 18478.076096195404, 18506.537336566693, 18515.444536663923, 18527.907360463112, 8058.234467725674, 8058.838823223503, 8081.838363232702, 8142.633581488847, 8299.83400332002, 4535.047639995638, 4551.3173024046, 4554.407926969539, 4565.429321334833, 4626.21354369758, 3117.0492999634876, 3122.500399935999, 3128.7340576050833, 3137.027521468352, 3148.2601588626653, 551.589066145724, 554.0441249478725, 563.0653115827706, 566.8781212039349, 582.1239035251918, 663.3234101216732, 664.4717449627558, 668.7224801707334, 672.5930811858852, 705.8200158959432, 8613.181747733955, 8625.39622226438, 8626.396152269406, 8821.144480317656, 8856.512891790884, 580.3181262017113, 663.8705452436728, 682.5836687379633, 690.4821383962028, 695.3776370148688, 3991.6207960243732, 4334.284843000933, 4395.780210989502, 4481.305397663367, 4504.144212599595, 54130.45869541333, 55397.72301138549, 55434.0, 55631.443685563434, 56006.43993560012, 48230.27654585184, 49110.50889491059, 49125.0, 49408.0, 49783.25325120126, 43811.0, 44140.99999999936, 44222.33666495005, 44241.0, 44601.10797784026, 7911.851331349943, 8226.588670566567, 8242.134575869688, 8244.29923456513, 8445.40882138269, 32533.0, 33140.502892457116, 33522.32955340831, 33594.32811343808, 33611.327773444886, 38608.0, 41625.79187104045, 42245.36631950585, 42745.57254427416, 43059.56940430681, 10284.691459256233, 10496.002879726413, 10655.627053053106, 11160.162987775788, 11404.372759498307, 11942.820857687315, 11973.161878668758, 11990.700232494257, 12163.574274900337, 12167.330796805907, 11159.609413670483, 11440.0, 11448.969592736694, 11499.0, 11663.88336116662, 11132.88867111351, 11189.216754827085, 11427.60003399877, 11466.770664586495, 11632.0, 10910.727231819268, 11137.164712646421, 11221.831672525082, 11328.773424531299, 11598.130140239684, 8955.327966844581, 8989.46063236208, 9106.0, 9120.978050563655, 9241.399309044891, 8299.751007469786, 9042.593083311136, 9377.765555861159, 9422.528873556157, 9491.905080949102], "unit": "score", "name": "yui.html", "value": 6296.845214360315}], "name": "dromaeo_css", "value": 6794.954101594606}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 108.0, 111.0, 112.0, 113.0, 102.0, 115.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 162.0, 166.0, 125.0, 151.0, 149.0, 127.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 161.0, 163.0, 161.0, 159.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 106.0, 95.0, 73.0, 75.0, 74.0, 118.0, 91.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 147.0, 95.0, 96.0, 96.0, 139.0, 96.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 55.0, 55.0, 56.0, 57.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 81.0, 83.0, 83.0, 81.0, 85.0, 82.0, 89.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 118.0, 123.0, 124.0, 116.0, 124.0, 121.0, 128.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [159.0, 140.0, 153.0, 150.0, 143.0, 142.0, 163.0, 150.0, 148.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 73.0, 72.0, 69.0, 70.0, 70.0, 72.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1517.2}]} 20:12:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1517.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6794.96"}}} 20:12:15 INFO - Return code: 0 20:12:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:12:15 INFO - # TBPL SUCCESS # 20:12:15 INFO - Running post-action listener: _resource_record_post_action 20:12:15 INFO - Running post-run listener: _resource_record_post_run 20:12:16 INFO - Total resource usage - Wall time: 1221s; CPU: 12.0%; Read bytes: 4096; Write bytes: 558743552; Read time: 16; Write time: 717048 20:12:16 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257650688; Read time: 0; Write time: 472264 20:12:16 INFO - run-tests - Wall time: 1205s; CPU: 12.0%; Read bytes: 4096; Write bytes: 301035520; Read time: 16; Write time: 244736 20:12:16 INFO - Running post-run listener: _upload_blobber_files 20:12:16 INFO - Blob upload gear active. 20:12:16 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:12:16 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 20:12:16 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'] 20:12:16 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 20:12:16 INFO - (blobuploader) - INFO - Open directory for files ... 20:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:17 INFO - (blobuploader) - INFO - Done attempting. 20:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:18 INFO - (blobuploader) - INFO - Done attempting. 20:12:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:12:18 INFO - Return code: 0 20:12:18 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:12:18 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:12:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/020ceb212b2d31d8325bd3b87e5f0304f295d2dc4f2a5ce1eb32f6a8cda63ff943e090f11772f9f2228ce62ae072a5e82b26980fe5aba331a290135f4bbadef9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81cc987ab3cb623f578dc8f9a86f6f25a31fef9faa14eb194509a6e0ad16bf078278b95930acca713a4423302cdcb465f47f996e177d268ccb4280c8cf8b3b00"} 20:12:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:12:18 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:12:18 INFO - Contents: 20:12:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/020ceb212b2d31d8325bd3b87e5f0304f295d2dc4f2a5ce1eb32f6a8cda63ff943e090f11772f9f2228ce62ae072a5e82b26980fe5aba331a290135f4bbadef9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81cc987ab3cb623f578dc8f9a86f6f25a31fef9faa14eb194509a6e0ad16bf078278b95930acca713a4423302cdcb465f47f996e177d268ccb4280c8cf8b3b00"} 20:12:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:12:18 INFO - Copying logs to upload dir... 20:12:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:12:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.884922 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-15 20:12:18.112979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 20:12:18.116854) ========= 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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 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/020ceb212b2d31d8325bd3b87e5f0304f295d2dc4f2a5ce1eb32f6a8cda63ff943e090f11772f9f2228ce62ae072a5e82b26980fe5aba331a290135f4bbadef9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81cc987ab3cb623f578dc8f9a86f6f25a31fef9faa14eb194509a6e0ad16bf078278b95930acca713a4423302cdcb465f47f996e177d268ccb4280c8cf8b3b00"} build_url:https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/cKoLOUNuSyCWPflJ7vEIUg/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/020ceb212b2d31d8325bd3b87e5f0304f295d2dc4f2a5ce1eb32f6a8cda63ff943e090f11772f9f2228ce62ae072a5e82b26980fe5aba331a290135f4bbadef9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81cc987ab3cb623f578dc8f9a86f6f25a31fef9faa14eb194509a6e0ad16bf078278b95930acca713a4423302cdcb465f47f996e177d268ccb4280c8cf8b3b00"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 20:12:18.141739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:12:18.142071) ========= 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=cbe409c6de289db6ac707de3000001d4-1455593854.733453-858236294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 20:12:18.225334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 20:12:18.225684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 20:12:18.226020) ========= ========= Total master_lag: 0.31 =========