builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1460627235.97 results: success (0) buildid: 20160413233016 builduid: f002c3e5467c49288839cab5fce7374b revision: dbb14513cb83681e2c2832c712b95c23bc9bf468 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:15.971847) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:15.972386) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:15.973032) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:15.996646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:15.996966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.216627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.217014) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.266246) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.266523) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.266913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.267200) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 02:47:16-- 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% 39.6M=0s 2016-04-14 02:47:16 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150695 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.430956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.431376) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014333 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.480729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:16.481081) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dbb14513cb83681e2c2832c712b95c23bc9bf468 --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 dbb14513cb83681e2c2832c712b95c23bc9bf468 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 02:47:16,855 truncating revision to first 12 chars 2016-04-14 02:47:16,856 Setting DEBUG logging. 2016-04-14 02:47:16,856 attempt 1/10 2016-04-14 02:47:16,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dbb14513cb83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 02:47:17,233 unpacking tar archive at: fx-team-dbb14513cb83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:17.162357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:17.162695) ========= echo dbb14513cb83681e2c2832c712b95c23bc9bf468 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dbb14513cb83681e2c2832c712b95c23bc9bf468'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dbb14513cb83681e2c2832c712b95c23bc9bf468 program finished with exit code 0 elapsedTime=0.004469 script_repo_revision: 'dbb14513cb83681e2c2832c712b95c23bc9bf468' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:17.212274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:17.212577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 02:47:17.222324) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-14 02:47:17.222668) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:47:17 INFO - MultiFileLogger online at 20160414 02:47:17 in /builds/slave/test-pgo 02:47:17 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 02:47:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:47:17 INFO - {'append_to_log': False, 02:47:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:47:17 INFO - 'blob_upload_branch': 'Fx-Team', 02:47:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:47:17 INFO - 'branch': 'Fx-Team', 02:47:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:17 INFO - 'config_files': ('talos/linux_config.py',), 02:47:17 INFO - 'default_actions': ('clobber', 02:47:17 INFO - 'read-buildbot-config', 02:47:17 INFO - 'download-and-extract', 02:47:17 INFO - 'populate-webroot', 02:47:17 INFO - 'create-virtualenv', 02:47:17 INFO - 'install', 02:47:17 INFO - 'run-tests'), 02:47:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:17 INFO - 'download_minidump_stackwalk': True, 02:47:17 INFO - 'download_symbols': 'ondemand', 02:47:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:17 INFO - 'installer_path': 'installer.exe', 02:47:17 INFO - 'log_level': 'info', 02:47:17 INFO - 'log_name': 'talos', 02:47:17 INFO - 'log_to_console': True, 02:47:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:47:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:47:17 INFO - 'opt_config_files': (), 02:47:17 INFO - 'pip_index': False, 02:47:17 INFO - 'sps_profile': False, 02:47:17 INFO - 'sps_profile_interval': 0, 02:47:17 INFO - 'suite': 'dromaeojs', 02:47:17 INFO - 'system_bits': '32', 02:47:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:17 INFO - 'title': 'talos-linux64-ix-041', 02:47:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:17 INFO - 'use_talos_json': True, 02:47:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:47:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:17 INFO - 'work_dir': 'build'} 02:47:17 INFO - ##### 02:47:17 INFO - ##### Running clobber step. 02:47:17 INFO - ##### 02:47:17 INFO - Running pre-action listener: _resource_record_pre_action 02:47:17 INFO - Running main action method: clobber 02:47:17 INFO - rmtree: /builds/slave/test-pgo/build 02:47:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:47:18 INFO - Running post-action listener: _resource_record_post_action 02:47:18 INFO - ##### 02:47:18 INFO - ##### Running read-buildbot-config step. 02:47:18 INFO - ##### 02:47:18 INFO - Running pre-action listener: _resource_record_pre_action 02:47:18 INFO - Running main action method: read_buildbot_config 02:47:18 INFO - Using buildbot properties: 02:47:18 INFO - { 02:47:18 INFO - "project": "", 02:47:18 INFO - "product": "firefox", 02:47:18 INFO - "script_repo_revision": "production", 02:47:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:47:18 INFO - "repository": "", 02:47:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:47:18 INFO - "buildid": "20160413233016", 02:47:18 INFO - "pgo_build": "True", 02:47:18 INFO - "basedir": "/builds/slave/test-pgo", 02:47:18 INFO - "buildnumber": 581, 02:47:18 INFO - "slavename": "talos-linux64-ix-041", 02:47:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:47:18 INFO - "platform": "ubuntu64_hw", 02:47:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:47:18 INFO - "branch": "fx-team", 02:47:18 INFO - "repo_path": "integration/fx-team", 02:47:18 INFO - "revision": "dbb14513cb83681e2c2832c712b95c23bc9bf468", 02:47:18 INFO - "stage_platform": "linux64-pgo", 02:47:18 INFO - "builduid": "f002c3e5467c49288839cab5fce7374b", 02:47:18 INFO - "slavebuilddir": "test" 02:47:18 INFO - } 02:47:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:47:18 INFO - Running post-action listener: _resource_record_post_action 02:47:18 INFO - ##### 02:47:18 INFO - ##### Running download-and-extract step. 02:47:18 INFO - ##### 02:47:18 INFO - Running pre-action listener: _resource_record_pre_action 02:47:18 INFO - Running main action method: download_and_extract 02:47:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:47: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')]} 02:47:18 INFO - https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:47:21 INFO - Downloaded 1361 bytes. 02:47:21 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:47:21 INFO - Using the following test package requirements: 02:47:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:47:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:47:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:47:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'jsshell-linux-x86_64.zip'], 02:47:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:47:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:47:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:47:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:47:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:47:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:47:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:47:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:47:21 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')]} 02:47:21 INFO - https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:47:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:47:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:47:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:47:26 INFO - Downloaded 23774862 bytes. 02:47:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:47:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:47:27 INFO - Return code: 0 02:47:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:47: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')]} 02:47:27 INFO - https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:47:29 INFO - Downloaded 23774862 bytes. 02:47:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:47:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:47:30 INFO - Return code: 0 02:47:30 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')]} 02:47:30 INFO - https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:47:31 INFO - Downloaded 10841076 bytes. 02:47:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:47:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 02:47:31 INFO - Return code: 0 02:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:31 INFO - https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:47:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:47:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:47:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:47:33 INFO - Downloaded 57873480 bytes. 02:47:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:47:33 INFO - mkdir: /builds/slave/test-pgo/properties 02:47:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:47:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:47:33 INFO - Contents: 02:47:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:47:34 INFO - Running post-action listener: _resource_record_post_action 02:47:34 INFO - Running post-action listener: set_extra_try_arguments 02:47:34 INFO - ##### 02:47:34 INFO - ##### Running populate-webroot step. 02:47:34 INFO - ##### 02:47:34 INFO - Running pre-action listener: _resource_record_pre_action 02:47:34 INFO - Running main action method: populate_webroot 02:47:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:47:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:47:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:47:34 INFO - '--tppagecycles', 02:47:34 INFO - '7'], 02:47:34 INFO - 'tests': ['tsvgm']}}, 02:47:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:47:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:47:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:47:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:47:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['damp', 'tps']}, 02:47:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'tests': ['damp', 'tps']}, 02:47:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['dromaeo_dom']}, 02:47:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:47:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['a11yr', 02:47:34 INFO - 'ts_paint', 02:47:34 INFO - 'tpaint', 02:47:34 INFO - 'sessionrestore', 02:47:34 INFO - 'sessionrestore_no_auto_restore', 02:47:34 INFO - 'tabpaint']}, 02:47:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:47:34 INFO - 'ts_paint', 02:47:34 INFO - 'tpaint', 02:47:34 INFO - 'sessionrestore', 02:47:34 INFO - 'sessionrestore_no_auto_restore', 02:47:34 INFO - 'tabpaint']}, 02:47:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:47:34 INFO - 'ts_paint', 02:47:34 INFO - 'tpaint', 02:47:34 INFO - 'sessionrestore', 02:47:34 INFO - 'sessionrestore_no_auto_restore', 02:47:34 INFO - 'tabpaint']}, 02:47:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:47:34 INFO - 'ts_paint', 02:47:34 INFO - 'tpaint', 02:47:34 INFO - 'sessionrestore', 02:47:34 INFO - 'sessionrestore_no_auto_restore', 02:47:34 INFO - 'tabpaint']}, 02:47:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['a11yr', 02:47:34 INFO - 'ts_paint', 02:47:34 INFO - 'tpaint', 02:47:34 INFO - 'sessionrestore', 02:47:34 INFO - 'sessionrestore_no_auto_restore', 02:47:34 INFO - 'tabpaint']}, 02:47:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['a11yr', 02:47:34 INFO - 'ts_paint', 02:47:34 INFO - 'tpaint', 02:47:34 INFO - 'sessionrestore', 02:47:34 INFO - 'sessionrestore_no_auto_restore', 02:47:34 INFO - 'tabpaint']}, 02:47:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['tsvgx', 02:47:34 INFO - 'tsvgr_opacity', 02:47:34 INFO - 'tart', 02:47:34 INFO - 'tscrollx', 02:47:34 INFO - 'cart']}, 02:47:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:47:34 INFO - 'tsvgr_opacity', 02:47:34 INFO - 'tart', 02:47:34 INFO - 'tscrollx', 02:47:34 INFO - 'cart']}, 02:47:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'talos_options': ['--disable-e10s'], 02:47:34 INFO - 'tests': ['tp5o']}, 02:47:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'tests': ['tp5o']}, 02:47:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'talos_options': ['--disable-e10s', 02:47:34 INFO - '--xperf_path', 02:47:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:34 INFO - 'tests': ['tp5n']}, 02:47:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:34 INFO - 'talos_options': ['--xperf_path', 02:47:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:34 INFO - 'tests': ['tp5n']}}, 02:47:34 INFO - 'talos.zip': {'path': '', 02:47:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:47:34 INFO - Running post-action listener: _resource_record_post_action 02:47:34 INFO - ##### 02:47:34 INFO - ##### Running create-virtualenv step. 02:47:34 INFO - ##### 02:47:34 INFO - Running pre-action listener: _resource_record_pre_action 02:47:34 INFO - Running main action method: create_virtualenv 02:47:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:47:34 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 02:47:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:47:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:47:34 INFO - Using real prefix '/usr' 02:47:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:47:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:47:36 INFO - Installing pip.................done. 02:47:36 INFO - Return code: 0 02:47:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:47:36 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')]} 02:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:36 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')]} 02:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:36 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:36 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 02:47:36 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 02:47:36 INFO - Using env: {'DISPLAY': ':0', 02:47:36 INFO - 'HOME': '/home/cltbld', 02:47:36 INFO - 'LANG': 'en_US.UTF-8', 02:47:36 INFO - 'LANGUAGE': 'en_US:en', 02:47:36 INFO - 'LOGNAME': 'cltbld', 02:47:36 INFO - 'MAIL': '/var/mail/cltbld', 02:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:36 INFO - 'MOZ_NO_REMOTE': '1', 02:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:36 INFO - 'NO_EM_RESTART': '1', 02:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:36 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:36 INFO - 'SHELL': '/bin/bash', 02:47:36 INFO - 'SHLVL': '1', 02:47:36 INFO - 'TERM': 'linux', 02:47:36 INFO - 'TMOUT': '86400', 02:47:36 INFO - 'USER': 'cltbld', 02:47:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:36 INFO - '_': '/tools/buildbot/bin/python'} 02:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:36 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 02:47:36 INFO - Cleaning up... 02:47:36 INFO - Return code: 0 02:47:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:47:36 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')]} 02:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:36 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')]} 02:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:36 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:36 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 02:47:36 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 02:47:36 INFO - Using env: {'DISPLAY': ':0', 02:47:36 INFO - 'HOME': '/home/cltbld', 02:47:36 INFO - 'LANG': 'en_US.UTF-8', 02:47:36 INFO - 'LANGUAGE': 'en_US:en', 02:47:36 INFO - 'LOGNAME': 'cltbld', 02:47:36 INFO - 'MAIL': '/var/mail/cltbld', 02:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:36 INFO - 'MOZ_NO_REMOTE': '1', 02:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:36 INFO - 'NO_EM_RESTART': '1', 02:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:36 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:36 INFO - 'SHELL': '/bin/bash', 02:47:36 INFO - 'SHLVL': '1', 02:47:36 INFO - 'TERM': 'linux', 02:47:36 INFO - 'TMOUT': '86400', 02:47:36 INFO - 'USER': 'cltbld', 02:47:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:36 INFO - '_': '/tools/buildbot/bin/python'} 02:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:37 INFO - Downloading/unpacking psutil>=0.7.1 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:47:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:39 INFO - Installing collected packages: psutil 02:47:39 INFO - Running setup.py install for psutil 02:47:39 INFO - building 'psutil._psutil_linux' extension 02:47:39 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 02:47:39 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 02:47:39 INFO - building 'psutil._psutil_posix' extension 02:47:39 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 02:47:39 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 02:47:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:39 INFO - Successfully installed psutil 02:47:39 INFO - Cleaning up... 02:47:39 INFO - Return code: 0 02:47:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:39 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:39 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 02:47:39 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 02:47:39 INFO - Using env: {'DISPLAY': ':0', 02:47:39 INFO - 'HOME': '/home/cltbld', 02:47:39 INFO - 'LANG': 'en_US.UTF-8', 02:47:39 INFO - 'LANGUAGE': 'en_US:en', 02:47:39 INFO - 'LOGNAME': 'cltbld', 02:47:39 INFO - 'MAIL': '/var/mail/cltbld', 02:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:39 INFO - 'MOZ_NO_REMOTE': '1', 02:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:39 INFO - 'NO_EM_RESTART': '1', 02:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:39 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:39 INFO - 'SHELL': '/bin/bash', 02:47:39 INFO - 'SHLVL': '1', 02:47:39 INFO - 'TERM': 'linux', 02:47:39 INFO - 'TMOUT': '86400', 02:47:39 INFO - 'USER': 'cltbld', 02:47:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:39 INFO - '_': '/tools/buildbot/bin/python'} 02:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:47:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:47:41 INFO - Installing collected packages: mozsystemmonitor 02:47:41 INFO - Running setup.py install for mozsystemmonitor 02:47:41 INFO - Successfully installed mozsystemmonitor 02:47:41 INFO - Cleaning up... 02:47:42 INFO - Return code: 0 02:47:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:47:42 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')]} 02:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:42 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')]} 02:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:42 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:42 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 02:47:42 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 02:47:42 INFO - Using env: {'DISPLAY': ':0', 02:47:42 INFO - 'HOME': '/home/cltbld', 02:47:42 INFO - 'LANG': 'en_US.UTF-8', 02:47:42 INFO - 'LANGUAGE': 'en_US:en', 02:47:42 INFO - 'LOGNAME': 'cltbld', 02:47:42 INFO - 'MAIL': '/var/mail/cltbld', 02:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:42 INFO - 'MOZ_NO_REMOTE': '1', 02:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:42 INFO - 'NO_EM_RESTART': '1', 02:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:42 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:42 INFO - 'SHELL': '/bin/bash', 02:47:42 INFO - 'SHLVL': '1', 02:47:42 INFO - 'TERM': 'linux', 02:47:42 INFO - 'TMOUT': '86400', 02:47:42 INFO - 'USER': 'cltbld', 02:47:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:42 INFO - '_': '/tools/buildbot/bin/python'} 02:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:47:42 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 02:47:42 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 02:47:42 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 02:47:42 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 02:47:42 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 02:47:42 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 02:47:44 INFO - Downloading blobuploader-1.2.4.tar.gz 02:47:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:47:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:47:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 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 02:47:44 INFO - Downloading docopt-0.6.1.tar.gz 02:47:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:47:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:47:44 INFO - Running setup.py install for blobuploader 02:47:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:47:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:47:44 INFO - Running setup.py install for requests 02:47:45 INFO - Running setup.py install for docopt 02:47:45 INFO - Successfully installed blobuploader requests docopt 02:47:45 INFO - Cleaning up... 02:47:45 INFO - Return code: 0 02:47:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:45 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:45 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 02:47:45 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 02:47:45 INFO - Using env: {'DISPLAY': ':0', 02:47:45 INFO - 'HOME': '/home/cltbld', 02:47:45 INFO - 'LANG': 'en_US.UTF-8', 02:47:45 INFO - 'LANGUAGE': 'en_US:en', 02:47:45 INFO - 'LOGNAME': 'cltbld', 02:47:45 INFO - 'MAIL': '/var/mail/cltbld', 02:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:45 INFO - 'MOZ_NO_REMOTE': '1', 02:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:45 INFO - 'NO_EM_RESTART': '1', 02:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:45 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:45 INFO - 'SHELL': '/bin/bash', 02:47:45 INFO - 'SHLVL': '1', 02:47:45 INFO - 'TERM': 'linux', 02:47:45 INFO - 'TMOUT': '86400', 02:47:45 INFO - 'USER': 'cltbld', 02:47:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:45 INFO - '_': '/tools/buildbot/bin/python'} 02:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:47:45 INFO - Running setup.py (path:/tmp/pip-etXm5e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:47:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:47:45 INFO - Running setup.py (path:/tmp/pip-4MlM6i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:47:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:47:45 INFO - Running setup.py (path:/tmp/pip-fTgBb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:47:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:47:45 INFO - Running setup.py (path:/tmp/pip-Pclgo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:47:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:47:45 INFO - Running setup.py (path:/tmp/pip-8Mle6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:47:46 INFO - Running setup.py (path:/tmp/pip-SqO2S7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:47:46 INFO - Running setup.py (path:/tmp/pip-wU2Mlo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:47:46 INFO - Running setup.py (path:/tmp/pip-BUFTew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:47:46 INFO - Running setup.py (path:/tmp/pip-qRMpWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:47:46 INFO - Running setup.py (path:/tmp/pip-mmLAMR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:47:46 INFO - Running setup.py (path:/tmp/pip-tSgMHK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:47:46 INFO - Running setup.py (path:/tmp/pip-CT7k8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:47:46 INFO - Running setup.py (path:/tmp/pip-uvRdAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:47:46 INFO - Running setup.py (path:/tmp/pip-dbp40Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:47:46 INFO - Running setup.py (path:/tmp/pip-p_X9Lc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:47:46 INFO - Running setup.py (path:/tmp/pip-o2RUl3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:47:46 INFO - Running setup.py (path:/tmp/pip-hV3fsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:47:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:47:46 INFO - Running setup.py install for manifestparser 02:47:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Running setup.py install for mozcrash 02:47:47 INFO - Running setup.py install for mozdebug 02:47:47 INFO - Running setup.py install for mozdevice 02:47:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Running setup.py install for mozfile 02:47:47 INFO - Running setup.py install for mozhttpd 02:47:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Running setup.py install for mozinfo 02:47:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Running setup.py install for mozInstall 02:47:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Running setup.py install for mozleak 02:47:47 INFO - Running setup.py install for mozlog 02:47:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:47:47 INFO - Running setup.py install for moznetwork 02:47:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:47:48 INFO - Running setup.py install for mozprocess 02:47:48 INFO - Running setup.py install for mozprofile 02:47:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:47:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:47:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:47:48 INFO - Running setup.py install for mozrunner 02:47:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:47:48 INFO - Running setup.py install for mozscreenshot 02:47:48 INFO - Running setup.py install for moztest 02:47:48 INFO - Running setup.py install for mozversion 02:47:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:47:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:47:48 INFO - Cleaning up... 02:47:48 INFO - Return code: 0 02:47:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:48 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:48 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 02:47:48 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 02:47:48 INFO - Using env: {'DISPLAY': ':0', 02:47:48 INFO - 'HOME': '/home/cltbld', 02:47:48 INFO - 'LANG': 'en_US.UTF-8', 02:47:48 INFO - 'LANGUAGE': 'en_US:en', 02:47:48 INFO - 'LOGNAME': 'cltbld', 02:47:48 INFO - 'MAIL': '/var/mail/cltbld', 02:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:48 INFO - 'MOZ_NO_REMOTE': '1', 02:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:48 INFO - 'NO_EM_RESTART': '1', 02:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:48 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:48 INFO - 'SHELL': '/bin/bash', 02:47:48 INFO - 'SHLVL': '1', 02:47:48 INFO - 'TERM': 'linux', 02:47:48 INFO - 'TMOUT': '86400', 02:47:48 INFO - 'USER': 'cltbld', 02:47:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:48 INFO - '_': '/tools/buildbot/bin/python'} 02:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:47:48 INFO - Running setup.py (path:/tmp/pip-QrJwbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:47:48 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)) 02:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:47:48 INFO - Running setup.py (path:/tmp/pip-p625wp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:47:49 INFO - Running setup.py (path:/tmp/pip-aOBJp8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:47:49 INFO - Running setup.py (path:/tmp/pip-eq02Yr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:47:49 INFO - Running setup.py (path:/tmp/pip-fwo7Wq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:47:49 INFO - Running setup.py (path:/tmp/pip-k4jr8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:47:49 INFO - Running setup.py (path:/tmp/pip-POPnC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:47:49 INFO - Running setup.py (path:/tmp/pip-qPdcyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:47:49 INFO - Running setup.py (path:/tmp/pip-d1gI4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:47:49 INFO - Running setup.py (path:/tmp/pip-__hNf1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:47:49 INFO - Running setup.py (path:/tmp/pip-ioaRn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:47:49 INFO - Running setup.py (path:/tmp/pip-bEEjUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:47:49 INFO - Running setup.py (path:/tmp/pip-eD9ECl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:47:49 INFO - Running setup.py (path:/tmp/pip-tKnzni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:47:49 INFO - Running setup.py (path:/tmp/pip-3lf3tT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:47:49 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)) 02:47:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:47:50 INFO - Running setup.py (path:/tmp/pip-j8JUxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:47:50 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)) 02:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:47:50 INFO - Running setup.py (path:/tmp/pip-oc9TjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:47:50 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)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:50 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)) 02:47:50 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)) 02:47:50 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)) 02:47:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:52 INFO - Downloading blessings-1.6.tar.gz 02:47:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:47:52 INFO - Installing collected packages: blessings 02:47:52 INFO - Running setup.py install for blessings 02:47:52 INFO - Successfully installed blessings 02:47:52 INFO - Cleaning up... 02:47:52 INFO - Return code: 0 02:47:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:47:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:47:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:47:52 INFO - Reading from file tmpfile_stdout 02:47:52 INFO - Current package versions: 02:47:52 INFO - argparse == 1.2.1 02:47:52 INFO - blessings == 1.6 02:47:52 INFO - blobuploader == 1.2.4 02:47:52 INFO - docopt == 0.6.1 02:47:52 INFO - manifestparser == 1.1 02:47:52 INFO - mozInstall == 1.12 02:47:52 INFO - mozcrash == 0.17 02:47:52 INFO - mozdebug == 0.1 02:47:52 INFO - mozdevice == 0.48 02:47:52 INFO - mozfile == 1.2 02:47:52 INFO - mozhttpd == 0.7 02:47:52 INFO - mozinfo == 0.9 02:47:52 INFO - mozleak == 0.1 02:47:52 INFO - mozlog == 3.1 02:47:52 INFO - moznetwork == 0.27 02:47:52 INFO - mozprocess == 0.22 02:47:52 INFO - mozprofile == 0.28 02:47:52 INFO - mozrunner == 6.11 02:47:52 INFO - mozscreenshot == 0.1 02:47:52 INFO - mozsystemmonitor == 0.0 02:47:52 INFO - moztest == 0.7 02:47:52 INFO - mozversion == 1.4 02:47:52 INFO - psutil == 3.1.1 02:47:52 INFO - requests == 1.2.3 02:47:52 INFO - wsgiref == 0.1.2 02:47:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:47:52 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')]} 02:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:52 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')]} 02:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:52 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:52 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 02:47:52 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 02:47:52 INFO - Using env: {'DISPLAY': ':0', 02:47:52 INFO - 'HOME': '/home/cltbld', 02:47:52 INFO - 'LANG': 'en_US.UTF-8', 02:47:52 INFO - 'LANGUAGE': 'en_US:en', 02:47:52 INFO - 'LOGNAME': 'cltbld', 02:47:52 INFO - 'MAIL': '/var/mail/cltbld', 02:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:52 INFO - 'MOZ_NO_REMOTE': '1', 02:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:52 INFO - 'NO_EM_RESTART': '1', 02:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:52 INFO - 'SHELL': '/bin/bash', 02:47:52 INFO - 'SHLVL': '1', 02:47:52 INFO - 'TERM': 'linux', 02:47:52 INFO - 'TMOUT': '86400', 02:47:52 INFO - 'USER': 'cltbld', 02:47:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:52 INFO - '_': '/tools/buildbot/bin/python'} 02:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 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)) 02:47:52 INFO - Cleaning up... 02:47:52 INFO - Return code: 0 02:47:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:47:52 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')]} 02:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:52 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')]} 02:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:52 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:52 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 02:47:52 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 02:47:52 INFO - Using env: {'DISPLAY': ':0', 02:47:52 INFO - 'HOME': '/home/cltbld', 02:47:52 INFO - 'LANG': 'en_US.UTF-8', 02:47:52 INFO - 'LANGUAGE': 'en_US:en', 02:47:52 INFO - 'LOGNAME': 'cltbld', 02:47:52 INFO - 'MAIL': '/var/mail/cltbld', 02:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:52 INFO - 'MOZ_NO_REMOTE': '1', 02:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:52 INFO - 'NO_EM_RESTART': '1', 02:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:52 INFO - 'SHELL': '/bin/bash', 02:47:52 INFO - 'SHLVL': '1', 02:47:52 INFO - 'TERM': 'linux', 02:47:52 INFO - 'TMOUT': '86400', 02:47:52 INFO - 'USER': 'cltbld', 02:47:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:52 INFO - '_': '/tools/buildbot/bin/python'} 02:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:53 INFO - Downloading/unpacking jsonschema 02:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:47:55 INFO - Downloading/unpacking functools32 (from jsonschema) 02:47:55 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 02:47:55 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 02:47:55 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 02:47:55 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 02:47:55 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 02:47:55 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 02:47:55 INFO - Downloading functools32-3.2.3-2.tar.gz 02:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:47:55 INFO - warning: no files found matching '*.txt' 02:47:55 INFO - no previously-included directories found matching 'build' 02:47:55 INFO - no previously-included directories found matching 'dist' 02:47:55 INFO - no previously-included directories found matching '.git*' 02:47:55 INFO - Installing collected packages: jsonschema, functools32 02:47:55 INFO - Running setup.py install for functools32 02:47:55 INFO - warning: no files found matching '*.txt' 02:47:55 INFO - no previously-included directories found matching 'build' 02:47:55 INFO - no previously-included directories found matching 'dist' 02:47:55 INFO - no previously-included directories found matching '.git*' 02:47:55 INFO - Successfully installed jsonschema functools32 02:47:55 INFO - Cleaning up... 02:47:55 INFO - Return code: 0 02:47:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:55 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 0x7f56863acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c46b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', '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 02:47:55 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 02:47:55 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 02:47:55 INFO - Using env: {'DISPLAY': ':0', 02:47:55 INFO - 'HOME': '/home/cltbld', 02:47:55 INFO - 'LANG': 'en_US.UTF-8', 02:47:55 INFO - 'LANGUAGE': 'en_US:en', 02:47:55 INFO - 'LOGNAME': 'cltbld', 02:47:55 INFO - 'MAIL': '/var/mail/cltbld', 02:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:55 INFO - 'MOZ_NO_REMOTE': '1', 02:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:55 INFO - 'NO_EM_RESTART': '1', 02:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:47:55 INFO - 'PWD': '/builds/slave/test-pgo', 02:47:55 INFO - 'SHELL': '/bin/bash', 02:47:55 INFO - 'SHLVL': '1', 02:47:55 INFO - 'TERM': 'linux', 02:47:55 INFO - 'TMOUT': '86400', 02:47:55 INFO - 'USER': 'cltbld', 02:47:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:55 INFO - '_': '/tools/buildbot/bin/python'} 02:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:55 INFO - Downloading/unpacking flake8 02:47:55 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 02:47:55 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 02:47:55 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 02:47:55 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 02:47:55 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 02:47:55 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 02:47:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:47:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:47:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:47:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:47:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:47:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:47:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:47:58 INFO - no previously-included directories found matching 'docs/_build' 02:47:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:47:58 INFO - Running setup.py install for pep8 02:47:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:47:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:47:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:47:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:47:58 INFO - no previously-included directories found matching 'docs/_build' 02:47:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:47:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:47:58 INFO - Cleaning up... 02:47:58 INFO - Return code: 0 02:47:58 INFO - Running post-action listener: _resource_record_post_action 02:47:58 INFO - Running post-action listener: _start_resource_monitoring 02:47:58 INFO - Starting resource monitoring. 02:47:58 INFO - ##### 02:47:58 INFO - ##### Running install step. 02:47:58 INFO - ##### 02:47:58 INFO - Running pre-action listener: _resource_record_pre_action 02:47:58 INFO - Running main action method: install 02:47:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:47:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:47:58 INFO - Reading from file tmpfile_stdout 02:47:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:47:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:47:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:47:58 INFO - Reading from file tmpfile_stdout 02:47:58 INFO - Output received: 02:47:58 INFO - Usage: mozinstall [options] installer 02:47:58 INFO - Options: 02:47:58 INFO - -h, --help show this help message and exit 02:47:58 INFO - -d DEST, --destination=DEST 02:47:58 INFO - Directory to install application into. [default: 02:47:58 INFO - "/builds/slave/test-pgo"] 02:47:58 INFO - --app=APP Application being installed. [default: firefox] 02:47:58 INFO - mkdir: /builds/slave/test-pgo/build/application 02:47:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 02:47:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 02:48:15 INFO - Reading from file tmpfile_stdout 02:48:15 INFO - Output received: 02:48:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:48:15 INFO - Running post-action listener: _resource_record_post_action 02:48:15 INFO - ##### 02:48:15 INFO - ##### Running run-tests step. 02:48:15 INFO - ##### 02:48:15 INFO - Running pre-action listener: _resource_record_pre_action 02:48:15 INFO - Running main action method: run_tests 02:48:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:48:15 INFO - Python 2.7.3 02:48:15 INFO - Return code: 0 02:48:15 INFO - grabbing minidump binary from tooltool 02:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:15 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 0x28bf1d0>, '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 0x28c2750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c2be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:48:15 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 02:48:15 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 02:48:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:48:15 INFO - Return code: 0 02:48:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:48:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:48:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:48:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:48:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:48:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:48:16 INFO - Return code: 0 02:48:16 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/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 02:48:16 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/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 02:48:16 INFO - Using env: {'DISPLAY': ':0', 02:48:16 INFO - 'HOME': '/home/cltbld', 02:48:16 INFO - 'LANG': 'en_US.UTF-8', 02:48:16 INFO - 'LANGUAGE': 'en_US:en', 02:48:16 INFO - 'LOGNAME': 'cltbld', 02:48:16 INFO - 'MAIL': '/var/mail/cltbld', 02:48:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:48:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:16 INFO - 'MOZ_NO_REMOTE': '1', 02:48:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:16 INFO - 'NO_EM_RESTART': '1', 02:48:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:48:16 INFO - 'PWD': '/builds/slave/test-pgo', 02:48:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:48:16 INFO - 'SHELL': '/bin/bash', 02:48:16 INFO - 'SHLVL': '1', 02:48:16 INFO - 'TERM': 'linux', 02:48:16 INFO - 'TMOUT': '86400', 02:48:16 INFO - 'USER': 'cltbld', 02:48:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076', 02:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:16 INFO - '_': '/tools/buildbot/bin/python'} 02:48:16 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/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 02:48:16 INFO - mozversion application_buildid: 20160413233016 02:48:16 INFO - mozversion application_changeset: dbb14513cb83681e2c2832c712b95c23bc9bf468 02:48:16 INFO - mozversion application_display_name: Nightly 02:48:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:48:16 INFO - mozversion application_name: Firefox 02:48:16 INFO - mozversion application_remotingname: firefox 02:48:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:48:16 INFO - mozversion application_vendor: Mozilla 02:48:16 INFO - mozversion application_version: 48.0a1 02:48:16 INFO - mozversion platform_buildid: 20160413233016 02:48:16 INFO - mozversion platform_changeset: dbb14513cb83681e2c2832c712b95c23bc9bf468 02:48:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:48:16 INFO - mozversion platform_version: 48.0a1 02:48:16 INFO - using testdate: 1460627296 02:48:16 INFO - actual date: 1460627296 02:48:16 INFO - starting webserver on 'localhost:55437' 02:48:16 INFO - SUITE-START | Running 2 tests 02:48:16 INFO - TEST-START | dromaeo_css 02:48:16 INFO - operating with platform_type : linux_ 02:48:16 INFO - Initialising browser for dromaeo_css test... 02:48:16 INFO - TEST-INFO | started process 31601 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprhpi0n/profile http://localhost:55437/getInfo.html) 02:48:20 INFO - PROCESS | 31601 | __metrics Screen width/height:1600/1200 02:48:20 INFO - PROCESS | 31601 | colorDepth:24 02:48:20 INFO - PROCESS | 31601 | Browser inner width/height: 1024/697 02:48:20 INFO - PROCESS | 31601 | __metrics 02:48:21 ERROR - PROCESS | 31601 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:48:22 INFO - TEST-INFO | 31601: exit 0 02:48:22 INFO - Browser initialized. 02:48:22 INFO - Running cycle 1/1 for dromaeo_css test... 02:48:22 INFO - TEST-INFO | started process 31683 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprhpi0n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:34 INFO - PROCESS | 31683 | RSS: Main: 152674304 02:48:34 INFO - PROCESS | 31683 | 02:49:25 INFO - PROCESS | 31683 | 1460627365449 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] 02:51:33 INFO - PROCESS | 31683 | Cycle 1(1): loaded http://localhost:55437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55437/tests/dromaeo/cssquery-ext.html) 02:51:34 INFO - PROCESS | 31683 | RSS: Main: 259883008 02:51:34 INFO - PROCESS | 31683 | 02:54:36 INFO - PROCESS | 31683 | Cycle 1(1): loaded http://localhost:55437/tests/dromaeo/cssquery-ext.html (next: http://localhost:55437/tests/dromaeo/cssquery-jquery.html) 02:54:36 INFO - PROCESS | 31683 | RSS: Main: 235528192 02:54:36 INFO - PROCESS | 31683 | 02:57:38 INFO - PROCESS | 31683 | Cycle 1(1): loaded http://localhost:55437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55437/tests/dromaeo/cssquery-mootools.html) 02:57:39 INFO - PROCESS | 31683 | RSS: Main: 237039616 02:57:39 INFO - PROCESS | 31683 | 03:00:41 INFO - PROCESS | 31683 | Cycle 1(1): loaded http://localhost:55437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55437/tests/dromaeo/cssquery-prototype.html) 03:00:41 INFO - PROCESS | 31683 | RSS: Main: 227627008 03:00:41 INFO - PROCESS | 31683 | 03:03:44 INFO - PROCESS | 31683 | Cycle 1(1): loaded http://localhost:55437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55437/tests/dromaeo/cssquery-yui.html) 03:03:44 INFO - PROCESS | 31683 | RSS: Main: 223170560 03:03:44 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | Cycle 1(1): loaded http://localhost:55437/tests/dromaeo/cssquery-yui.html (next: http://localhost:55437/tests/dromaeo/cssquery-dojo.html) 03:06:47 INFO - PROCESS | 31683 | RSS: Main: 260956160 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | __start_tp_report 03:06:47 INFO - PROCESS | 31683 | _x_x_mozilla_page_load 03:06:47 INFO - PROCESS | 31683 | _x_x_mozilla_page_load_details 03:06:47 INFO - PROCESS | 31683 | |i|pagename|runs| 03:06:47 INFO - PROCESS | 31683 | |0;dojo.html;3140.7487401007916;3163.6203655561335;3191.1064901827494;3222.7099561039518;3252;5255.1329030709985;5369.087255166622;5379.67721936684;5406.83779486615;5470.343558772948;5406.945930540694;5442.401335853053;5453.672779633225;5454.4545545445435;5472.179173124024;4795.592374648159;4856.368672072635;4967.50324967504;5012.548870601645;5040.6471546991725;4789.497102804207;4938.432080310757;4966.404031516205;4995.175795993657;5035.093683137034;4856.708597484145;4885.902281954359;4931.482194369593;4937.6049916007;4953.529414705633;4922.581580565657;4928.67963582366;4932;4956.702597844141;4972.378452693413;4754.595859351959;4855.271709243606;4873.6832105913;4882.707037577757;4932.161532539477;5316.096263635152;5355.116405793039;5361.035013697533;5369.570434365241;5391.81128660499;5810.82567522975;5812.041013232812;5839.036558967765;5841.591088623798;5845.649261044308;5703.31560212773;5853.209816674737;5876.7355469004;5891.941080589225;5942.5840191186635;5483.067878460672;5484.424135465799;5487.533559647435;5492.368377636543;5517.44825517445;5993;5994.820155395345;5996.340402555716;5996.820095397145;6000.669963151981;5504.504594586427;5744.224529688522;5752.654840709571;5800.767969281266;5848.1227815827115;5783.71081445926;5784.074548072288;5791.131330300404;5792.652440853562;5792.913106303409;5759.452851979139;5763.798267060716;5765.538756899438;5767.192593036978;5769.711514424262;5618.719064046782;5820.330661973842;5850.678212698343;5873.911891321633;5897.941020589825;4355.412019377343;4375.256206444912;4381.78091095444;4385.583369579885;4413.22768515515;3817.0457385653585;3924.6467817895955;3944.4674968878835;3965.365541513344;3985.7608543487486;5468.808591699271;5497;5518.613697041169;5559.027170245272;5567.66594004361;5869.178315035899;5894.528437724972;5905.586608937333;5905.734241959036;5906.40935906406;5298.523132917979;5497.45025497447;5533.059379905426;5546.389897111315;5554.361248456479;4861.732604706775;4862.82980095702;4863.221884498464;4869.829555965524;4909.803607855646;6026.789062382795;6027.969860150759;6029.728662210211;6030.487408570233;6032.668203248863;5667.121596152603;5838.357780644041;5859.179714840011;5920.79277225295;5940.910886336795;5951.940480595312;5956.821295361146;5957.761689532544;5958.791442299672;5978.432048955342;5654.236678048411;5657.971710141423;5661;5672.971635141798;5679.261695979496;5670.5180059695385;5774.653520788766;5848.181254624441;5918.201042859331;5945.524358051259;5685.744141513559;5686.289213848269;5697.4587414195585;5697.6296540724725;5699.544036477155;5621.156826476062;5670.234518339971;5675.858103547444;5677.148427735708;5679;5467.781288748405;5630.8029218977135;5686.800961966312;5710.486056254957;5740.483356497935;5718.942810572007;5721.828345149652;5748.885022299614;5750.194972703741;5752.511036561939;5428.647137936022;5625.128105143709;5626.43735626434;5627.634203776742;5668.801591944262 03:06:47 INFO - PROCESS | 31683 | |1;ext.html;601.837503873954;637.9744810207592;649.1269242868341;658.8912829383154;672.4250765595413;30887.227819304528;31732.841335793346;31844.20389490264;31915.521267180982;37373;40266.39600405996;40536.189276214456;40537.59462405375;41018.58981410193;41218.58781412185;8560.614772335228;8776.166264204921;8784.64861405543;8788.604512796908;8794.912050879506;8556.572171391437;8654.177853103945;8655.913440865574;8694.652213911468;8702.086280940504;8629.95685021574;8877.644894204224;8880.289576833839;8893.733188004338;8906.287497000258;8753.999999999936;8754.168354006359;8761.474311541297;8762.693305734301;8788.34087443441;8744.825103497958;8827.955860220722;8834;8837.027926928033;8859.911400886038;40964;41405.37891931624;41499.377509337384;41678.37482437766;41685.166296673895;3416.8633254669785;3455.6198818129988;3637.6180501047274;3688.7786732796117;4093.8741845992295;31035;32126;32171.19572010695;32265.838670806497;32271.193220169447;4279.978600107011;4384.430024096879;4388;4388.802503887333;4430.26900561407;290440;291781;292192;293547;294268;58431.12353314704;58457.70771146117;58875.70562147162;58876.70561647164;58930.41069589335;55138.448615514135;64298.67850660717;65586.34413655898;66088.66955665287;66194.35222591138;17314.393996210325;17827.910860445616;17835.197416116305;17871;17890.463286101436;13460.663483412796;13593.320333983262;13670.794938075738;13673.726525469436;13681;19584.8041519583;19996.700049499268;20044.398668039692;20079.196832126843;20131.597368052557;7139.178994415604;7146.78065295773;7350.686067362901;7407.962960185272;7482.6632801524065;1031.8761748590066;1048.4128887822844;1079.4017485511777;1136.5056200552622;1251.9687007824878;32587.34825303528;33047.50428743571;33156.1710957228;33505.329893402;33845;1101.8292164714483;1140.680609429361;1164.7612239490884;1197.6167626359481;1200.1299058182922;17214.827851721322;17665.763396562117;17666.470005899842;17709.557261068578;17721.468355949342;437824;441555;442035;442803;443786;59071.70464147738;59456;60081;60217.09674354888;60235.69882150561;1224.8591411987736;1401.7336706025822;1402.5371627362742;1423.6013916103507;1427.4789701758991;28591.14226573123;30215.848920756136;30716.539251911687;30758.231044224074;31422;47023;47201.29198061963;47477.76261118672;47499.76250118727;47514.52485475101;279583;281738;281793;281917;283027;26173.345666358495;28195;28280.71719282863;28810.7118928808;29210;41469.79265103655;41533.79233103936;41937.79031104825;42740.358894617224;42889;35982;39006;39441;39737.80131099326;39773.40339894846;39075;39141.804290979504;39323;39706.40440393454;39719.40420893747;40211.195776084896;41038.17923641451;41165.382519262836;41429.79285103555;41470.1705965873;34189.14527136841;34800.30399391947;35459.290814183056;35691.46462803008;35764.4635330465;27164.72835271701;27259.633231865293;27416;27429.45141097207;27817.165485035483 03:06:47 INFO - PROCESS | 31683 | |2;jquery.html;396.8670495384046;399.54451924805727;399.65629558579633;402.26385714143123;402.7241339682318;18116.90941545292;18443.631127377444;18751.3437029704;18811.529711757197;19583;18652.813471865276;18754.718679219823;19063.52341191471;19830;19865.900670496663;5533.170024496318;5534.363548191969;5552.250446189773;5562.610617256793;5695.03184458643;5485.424030476803;5644.8306550803545;5651.06757385031;5672.744726487318;5685.431456854323;5423.7830486780485;5616.269884914956;5617.4382561743705;5617.578681598897;5632.35227948787;5570.637908535952;5606.467385598362;5611.438856114356;5614.29821272341;5624.437556244384;4816.205326121186;4919.975400122977;4937.061958227925;4950.455449900508;4961.578265847371;22341;22389.888050559806;22753.9961867591;22989.310320690238;23030.769692303198;2221.9555608887895;2289.9084036638515;2338.580596263268;2383.785459308653;2408.987955060231;14379.137251764927;14473;14494.637634059127;14520.201388923604;14803.555893323217;1852.8610354223351;1924.0668275886185;1992.940211793634;2007.3576455534235;2069.9960519148203;74779.62610186968;86503;91082;95549;98336;16192.433264835674;16771.413000544922;17051.481357440287;17589.12054397275;17741.78227721535;32396.190095247806;32441.351172976407;32772.34455310881;32912.506312405334;32944.505832412535;10042.246831487668;10164;10253.794924101476;10365.948170259251;10483.633072842567;8155.918440815634;8277.089520152778;8325.333973282122;8411.285040771603;8426.536540490331;8681.739547813575;8733.126687331343;8783.560821958876;8917.910820891708;9064.138906803842;3164.398764234788;3248.2691394436065;3309;3408.6761757632985;3475.2354482013916;758.3629751009179;905.5064989580694;995.4326034160459;1010.5957616953131;1055.4775386183735;18631.627367452846;19173.90413047926;19537.706934395996;19639.803601964082;19832.107555159764;969.2972594868663;979.4612962870393;989.6303087985422;1002.644061358222;1113.2541197397763;10566.76749144636;10888.012012431489;10974.451277436096;10977.560897564008;10979.066779323688;454049;457810;458197;458866;479657;71898;85332.57333713291;91565;94509;96627.51686241524;1030.6032177611523;1038.7351225437465;1043.2905624175633;1054.1882750282393;1063.1494804156644;16222.837771622133;16814.159292035103;17177;17209.225584848962;17288.222030008932;36085.81957090198;36470.4529432064;37276;37570.24859502849;38292.61707382891;48447.5155248443;50092.499075010244;51467.48532514627;51945;51961;8608.870866937126;8633.223009929137;8728.607212675572;8735.43219690718;8799.164079412445;9954.850677239992;13386.732265354443;13606.86393136056;13746.65633359134;13841.653958651113;11822.408879555816;11908.404579770804;11985.580504682293;12020.25706272603;12091.214071085351;11987.100967427303;12017.399130043288;12060.276383417024;12174.878251217375;12461.252324860538;12154.513819447124;12386.132970691964;12435.440405181607;12510.937445312715;12545.93727031359;7554.886676699744;7847.607619619111;7900.723474678359;8004.079530854026;8815.955920220358;11524.711882203012;11870.762584748429;11927.76144477123;12033.518659253532;12359.32023738703 03:06:47 INFO - PROCESS | 31683 | |3;mootools.html;1305.2755720575078;1542.4755583101744;1544.3590909772445;1748.1346733366977;1867.5237814357345;8085.676572937083;8447.197516235949;8447.493150410979;8462.703805366806;8473.067962524117;8240.381971352143;8390.790230244247;8395.83208335833;8396.958015209932;8405.705800296992;2016.959660806783;2071.585682863426;2320.5938960681897;2353.49399879026;2395.832291739579;2408.5544174327806;2434.75652434756;2441.0235905637796;2442.584760590695;2444.6210837320245;2316.837821352506;2343.4610039690883;2344.5545346384133;2346.671465994762;2372.7627237276306;1966.1349006437122;2203.5262418580082;2267.716535433071;2268.5009297954507;2284.3603790938564;2230.7546169921297;2252.6395776675818;2252.831037672181;2255.9774402256094;2256.199049337494;8195.549244791535;8243.175682431769;8249.958750206271;8267.214614611603;8273.420860539765;4918.9754051229875;5064.11378008847;5067.898642027176;5088.92366614501;5099.031184075014;3121.9687803121906;3152.085895090421;3248.5614442050255;3250.2686895448574;3270.6565810590023;1113.3208742666966;1115.341948250536;1138.245446020632;1138.3852719531444;1149.074994629323;11375.772484550263;11523.96284334414;11553.24903881245;11587.130965177561;11594;4593.150267200579;4601.493835678073;4795.040991801654;4843.806247750051;4852.961756062462;10000.699979000641;10002.499875006366;10058.295919285727;10074.74813129663;10077.143442807297;5347.545458635982;5349.090654588729;5366.517013468807;5386.67679939197;5397.514223719884;4189.476315460567;4733.148033354029;4854.393200849894;4874.561289483963;4923.187674033816;3916.3929590913453;3949.30887094763;3991.7604943703473;4014.979925100414;4076.6534844538546;1274.9681257968439;1305.4973835073565;1328.0637150808657;1335.6460537957448;1340.1088276296155;973.5667627905514;978.0854900667898;987.1165307050294;1005.1205195453978;1005.3612611443301;5746.798862039892;5839.0949402842625;5903.76384944606;5911.4975227105315;6013.398660133952;941.1012483078644;953.3564843730454;957.8658987741721;976.8192884316425;992.831218692824;4065.329220678614;4124.8556300529335;4126.607972242632;4128.525219599725;4131.669466442678;9884.11043006133;10211.336263142872;10308.226882983807;10323.741906452398;10327.070563649308;10364.429956352322;10542.631007914839;10544.789104217873;10554.261201715959;10557.47212639365;7493.213212612706;7704.8844267336035;7720.189380115119;7786.299233069051;7892.0529536456;5664.518515926027;5831.533477321719;5912.083627037816;5953.464188223081;6034.155218269533;9398.436093834393;9495.287853410884;9563.426194428357;9569.904300956901;9699.272554558578;9219.216366608645;9632.325737198329;9751.51242437861;9855.950720246354;9870.210383169473;7299.708011679686;7436.590987495523;7511.06111736033;7518.699252029857;7521.7743467696055;7817.296443320129;7819.257170568787;7847.9215207849475;8087.47431416956;8153.103158652425;7139.286071392819;7381.483296169216;7481.10226772769;7565.773026809205;7581.734639287599;7182.245864184394;7306.744263950736;7307.963460182665;7345.22875098107;7389.852202956018;6912.654367281515;6961.6519174042105;6981.336773006759;6989.196242431982;6997.930020699728;5017.648764586444;5038.823641172541;5053.949460505495;5155.149400348901;5160.922586161286;4968.2795994579865;5093.974530127326;5102.846914592568;5126.615503837153;5272.472752724697 03:06:47 INFO - PROCESS | 31683 | |4;prototype.html;333.11391698083094;337.5156650206952;345.2508057515192;352.698442831379;353.56688057130003;5573.47052030057;5605.859853503664;5611.382747897728;5642.15367694846;5707.172459993309;5561.165825126233;5578.665280083198;5584.748686309115;5589.580781441398;5590.217369568264;3973.6308511353895;4096.873359826041;4192.392103145042;4283.736297792158;4286.0999190170105;4275.700700950934;4286.76422796746;4293.248681480744;4301.741895486265;4303.397524346594;4264.616184543391;4265.168292183025;4267.658587313023;4270;4282.721623094504;4065.6137666921745;4181.477315335598;4276.657867370634;4296.914061718748;4320;3810.1998580297895;3815.294170578424;3828.712846536521;3830.2148059647707;3837.7313588048846;5301.814436494704;5317.41508434072;5320.920186197211;5323.813666521692;5350.8127215547265;4945.678530895516;5039.143345631252;5056.317397151374;5059.418166910778;5061.139606266944;5845.85385365365;5846.123081537761;5877.9412205877825;5884.735186916599;5903.675297858616;4255.255330317182;4267.722598031118;4271.252530807127;4274.2092712848225;4279.40088387626;5778.855528611776;5871.412858714137;5882.264716910429;6073.726682299307;6101.633901965852;4326.805293761789;4364.192624364503;4383.07955329378;4385.276429389115;4385.780710964439;4413.558644135625;4416.183006143874;4419.801108950105;4421.358902959053;4424.358468022118;4895.167821470359;5002.674826136289;5015.498450154955;5017.8243761468175;5032.194848824171;5835.912461312999;5880.0003999320215;5883.61756485827;5904.321003084614;5917.260342457193;1522.208451605159;1524.336913442656;1527.6486408126193;1532.6091846579275;1532.8160620725585;1012.5342342522522;1055.5566662001977;1056.3028401255135;1064.2762921213493;1065.2649671726638;5611.80358687444;5629.211910332557;5655.123455864347;5663.093904975184;5702.942970570241;5979.279427860313;5995.160677505153;6020.518358531307;6059.272887253558;6066.726997285133;5496.1755736639825;5697.829065128053;5704.686242256716;5719.5138413235345;5726.713664316768;3167.4140284047526;3201.439748044083;3205.599300087489;3221.2269055426527;3231.757618178646;6038.818835434944;6190.380961903774;6206.255249370014;6207.844803879939;6246.843828904223;6056.394360563909;6111.877762444727;6128.295246046761;6129.387061293835;6145.692715364214;6197.380261973857;6223.844403889939;6227.346128656516;6228.5951413158;6238.563300569007;5811.389804070681;5930.762769489172;6022.09668549721;6033;6059.818205453844;5914.658218106756;5922.111683247547;5956.583039187389;5969.701514924323;5997.570983751588;5988.760449582142;6080.148779171008;6286.811395658137;6329.30377658448;6340.9048864268;4349.3475978603465;4377.10269394767;4380.824767009284;4388.341748737587;4392.6705497087205;5863.73613187399;6067.362926892789;6132.601380910227;6137.35557766446;6158.6304821709045;5955.315138759098;5967.582269241285;5976.312724036791;5989.101634754822;6005.099235114768;5950.553708471795;5968;5970.58205925581;5970.582059255984;5983.880322393615;5686.601937864475;5880.94119058804;5892.852678682896;5895.793647222326;5900.763969441346;5950.702464876826;5952.5833191676165;5968.522518198447;6016.458518733335;6032.8793424132145;5803.390643982321;5911.527077833849;5920.467157955804;5921.3782552831335;5924.140999555127 03:06:47 INFO - PROCESS | 31683 | |5;yui.html;766.7086507127291;858.742377286814;865.7143142762889;871.8212766382889;881.1056777370969;12867.292298923556;13026.934865325684;13029.153105048177;13081.084324097317;13208;11296.548138074468;12969.870301296984;13037;13040.804387934164;13079.149855259402;816.2490508731951;839.9076101628816;844.4173520271024;847.3052097280232;848.1560846957286;836.995815020924;839.3704721458906;839.5382539603224;843.2874221283006;845.0830848529353;703.1456780012284;873.52829472085;878.44218920985;878.565110270417;878.6134100995573;855.6962278391175;873.5195642396689;874.2306770042322;875.2166810704448;876.8509353409904;639.0956796133465;643.2955913274957;644.2591020326615;644.9161608990848;644.9903251451232;13397.19616822984;13432.798508022388;13502.122362046435;13529.59411217665;13532.661683457894;14068.788968165485;14235.074720143157;14290;14299.57101286963;14407.567772966722;10580.841287380696;10758.623448179354;10797.190210734227;10870.402127882964;10928.617498387519;3884.5532763731967;3896.7077469189926;3927.3912543555793;3929.8035098244973;3988.0029992501873;55250.723746381416;55304.72347638236;55475.16787248194;55579.44420555783;55675;10731.517081731341;10996.890031099747;11034.282771619979;11050;11126.777464450666;19243.51891202703;19304.517387065436;19327.8067219326;19328.71006934897;20400;7219.639018049076;7925.762227133196;8342.833143337099;8370.372222083368;8631.741047768577;4561.908761824745;4632.305154226893;4674.439067311944;4760.571548560646;4831.4685384607665;3393.0669066007044;3495.4232551629207;3495.615482296945;3500.5099286099967;3503.159241781954;629.7795771480037;635.9427651511386;638.6998110887876;644.9645269510128;649.3279455763262;615.673692942741;693.9880916821021;725.3906718356606;755.6184127015932;775.3835700618022;8601.096884827128;8849.115088491099;8905.198532132139;8982.820343593092;8999.32505062123;643.9162908821917;724.3336130759714;771.7106085218044;774.3843644302793;795.3120550723582;4201.2017716633745;4427.579379958899;4428.3800267962515;4470.977645111819;4524.479684836286;62386.37613623896;62790.37209627937;63196.36803631905;64717;64906;53712.73143634257;54316.45683543193;54381.1842822358;54941;55050.724746376814;41662.583374166476;42555.7872210637;47757.76121119303;48509.5149048512;50365.74817125891;8806.603702833516;8862.822743545223;9165;9210.401323913924;9217.539123043687;26632.866835665696;30559.2360190997;31168.532472012485;31860.362792743552;32109.839450802596;40791.38812917868;44917.326240107075;45060;45071.09857802891;45877.54122458733;12033.699157521132;12114.394280285775;12150.21023633461;12158.513659453876;12210.206336588093;11268.15488838324;11781.410929453321;12917.741645167232;12953.935230323788;12954.80567791465;11813.645590632295;12154.939225303817;12271.447784849524;12650.177738446971;12800.423980921067;11645.243059201124;12266.693332666755;12341.136120471481;12832.679183020498;12865.228086314852;11814.704632384259;11846.11154163424;11865.169438139248;12162.939185304016;12385.071119666241;10295.330803497749;10315.381077135396;10329.225308101772;10591.576336946437;10599.947000264949;10471.94764026175;10499.965300841872;10532.842007370049;10873.782524349626;10930.781384372109 03:06:47 INFO - PROCESS | 31683 | __end_tp_report 03:06:47 INFO - PROCESS | 31683 | __start_cc_report 03:06:47 INFO - PROCESS | 31683 | _x_x_mozilla_cycle_collect,839 03:06:47 INFO - PROCESS | 31683 | __end_cc_report 03:06:47 INFO - PROCESS | 31683 | __startTimestamp1460628407643__endTimestamp 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | ------- Summary: start ------- 03:06:47 INFO - PROCESS | 31683 | Number of tests: 6 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | [#0] dojo.html Cycles:165 Average:5393.86 Median:5627.63 stddev:623.39 (11.1%) stddev-sans-first:599.72 03:06:47 INFO - PROCESS | 31683 | Values: 3140.7 3163.6 3191.1 3222.7 3252.0 5255.1 5369.1 5379.7 5406.8 5470.3 5406.9 5442.4 5453.7 5454.5 5472.2 4795.6 4856.4 4967.5 5012.5 5040.6 4789.5 4938.4 4966.4 4995.2 5035.1 4856.7 4885.9 4931.5 4937.6 4953.5 4922.6 4928.7 4932.0 4956.7 4972.4 4754.6 4855.3 4873.7 4882.7 4932.2 5316.1 5355.1 5361.0 5369.6 5391.8 5810.8 5812.0 5839.0 5841.6 5845.6 5703.3 5853.2 5876.7 5891.9 5942.6 5483.1 5484.4 5487.5 5492.4 5517.4 5993.0 5994.8 5996.3 5996.8 6000.7 5504.5 5744.2 5752.7 5800.8 5848.1 5783.7 5784.1 5791.1 5792.7 5792.9 5759.5 5763.8 5765.5 5767.2 5769.7 5618.7 5820.3 5850.7 5873.9 5897.9 4355.4 4375.3 4381.8 4385.6 4413.2 3817.0 3924.6 3944.5 3965.4 3985.8 5468.8 5497.0 5518.6 5559.0 5567.7 5869.2 5894.5 5905.6 5905.7 5906.4 5298.5 5497.5 5533.1 5546.4 5554.4 4861.7 4862.8 4863.2 4869.8 4909.8 6026.8 6028.0 6029.7 6030.5 6032.7 5667.1 5838.4 5859.2 5920.8 5940.9 5951.9 5956.8 5957.8 5958.8 5978.4 5654.2 5658.0 5661.0 5673.0 5679.3 5670.5 5774.7 5848.2 5918.2 5945.5 5685.7 5686.3 5697.5 5697.6 5699.5 5621.2 5670.2 5675.9 5677.1 5679.0 5467.8 5630.8 5686.8 5710.5 5740.5 5718.9 5721.8 5748.9 5750.2 5752.5 5428.6 5625.1 5626.4 5627.6 5668.8 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | [#1] ext.html Cycles:180 Average:51108.52 Median:39712.90 stddev:91176.61 (229.6%) stddev-sans-first:91353.53 03:06:47 INFO - PROCESS | 31683 | Values: 601.8 638.0 649.1 658.9 672.4 30887.2 31732.8 31844.2 31915.5 37373.0 40266.4 40536.2 40537.6 41018.6 41218.6 8560.6 8776.2 8784.6 8788.6 8794.9 8556.6 8654.2 8655.9 8694.7 8702.1 8630.0 8877.6 8880.3 8893.7 8906.3 8754.0 8754.2 8761.5 8762.7 8788.3 8744.8 8828.0 8834.0 8837.0 8859.9 40964.0 41405.4 41499.4 41678.4 41685.2 3416.9 3455.6 3637.6 3688.8 4093.9 31035.0 32126.0 32171.2 32265.8 32271.2 4280.0 4384.4 4388.0 4388.8 4430.3 290440.0 291781.0 292192.0 293547.0 294268.0 58431.1 58457.7 58875.7 58876.7 58930.4 55138.4 64298.7 65586.3 66088.7 66194.4 17314.4 17827.9 17835.2 17871.0 17890.5 13460.7 13593.3 13670.8 13673.7 13681.0 19584.8 19996.7 20044.4 20079.2 20131.6 7139.2 7146.8 7350.7 7408.0 7482.7 1031.9 1048.4 1079.4 1136.5 1252.0 32587.3 33047.5 33156.2 33505.3 33845.0 1101.8 1140.7 1164.8 1197.6 1200.1 17214.8 17665.8 17666.5 17709.6 17721.5 437824.0 441555.0 442035.0 442803.0 443786.0 59071.7 59456.0 60081.0 60217.1 60235.7 1224.9 1401.7 1402.5 1423.6 1427.5 28591.1 30215.8 30716.5 30758.2 31422.0 47023.0 47201.3 47477.8 47499.8 47514.5 279583.0 281738.0 281793.0 281917.0 283027.0 26173.3 28195.0 28280.7 28810.7 29210.0 41469.8 41533.8 41937.8 42740.4 42889.0 35982.0 39006.0 39441.0 39737.8 39773.4 39075.0 39141.8 39323.0 39706.4 39719.4 40211.2 41038.2 41165.4 41429.8 41470.2 34189.1 34800.3 35459.3 35691.5 35764.5 27164.7 27259.6 27416.0 27429.5 27817.2 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | [#2] jquery.html Cycles:180 Average:28968.43 Median:17844.81 stddev:76183.72 (426.9%) stddev-sans-first:76367.24 03:06:47 INFO - PROCESS | 31683 | Values: 396.9 399.5 399.7 402.3 402.7 18116.9 18443.6 18751.3 18811.5 19583.0 18652.8 18754.7 19063.5 19830.0 19865.9 5533.2 5534.4 5552.3 5562.6 5695.0 5485.4 5644.8 5651.1 5672.7 5685.4 5423.8 5616.3 5617.4 5617.6 5632.4 5570.6 5606.5 5611.4 5614.3 5624.4 4816.2 4920.0 4937.1 4950.5 4961.6 22341.0 22389.9 22754.0 22989.3 23030.8 2222.0 2289.9 2338.6 2383.8 2409.0 14379.1 14473.0 14494.6 14520.2 14803.6 1852.9 1924.1 1992.9 2007.4 2070.0 74779.6 86503.0 91082.0 95549.0 98336.0 16192.4 16771.4 17051.5 17589.1 17741.8 32396.2 32441.4 32772.3 32912.5 32944.5 10042.2 10164.0 10253.8 10365.9 10483.6 8155.9 8277.1 8325.3 8411.3 8426.5 8681.7 8733.1 8783.6 8917.9 9064.1 3164.4 3248.3 3309.0 3408.7 3475.2 758.4 905.5 995.4 1010.6 1055.5 18631.6 19173.9 19537.7 19639.8 19832.1 969.3 979.5 989.6 1002.6 1113.3 10566.8 10888.0 10974.5 10977.6 10979.1 454049.0 457810.0 458197.0 458866.0 479657.0 71898.0 85332.6 91565.0 94509.0 96627.5 1030.6 1038.7 1043.3 1054.2 1063.1 16222.8 16814.2 17177.0 17209.2 17288.2 36085.8 36470.5 37276.0 37570.2 38292.6 48447.5 50092.5 51467.5 51945.0 51961.0 8608.9 8633.2 8728.6 8735.4 8799.2 9954.9 13386.7 13606.9 13746.7 13841.7 11822.4 11908.4 11985.6 12020.3 12091.2 11987.1 12017.4 12060.3 12174.9 12461.3 12154.5 12386.1 12435.4 12510.9 12545.9 7554.9 7847.6 7900.7 8004.1 8816.0 11524.7 11870.8 11927.8 12033.5 12359.3 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | [#3] mootools.html Cycles:180 Average:5609.21 Median:5059.03 stddev:3089.09 (61.1%) stddev-sans-first:3080.82 03:06:47 INFO - PROCESS | 31683 | Values: 1305.3 1542.5 1544.4 1748.1 1867.5 8085.7 8447.2 8447.5 8462.7 8473.1 8240.4 8390.8 8395.8 8397.0 8405.7 2017.0 2071.6 2320.6 2353.5 2395.8 2408.6 2434.8 2441.0 2442.6 2444.6 2316.8 2343.5 2344.6 2346.7 2372.8 1966.1 2203.5 2267.7 2268.5 2284.4 2230.8 2252.6 2252.8 2256.0 2256.2 8195.5 8243.2 8250.0 8267.2 8273.4 4919.0 5064.1 5067.9 5088.9 5099.0 3122.0 3152.1 3248.6 3250.3 3270.7 1113.3 1115.3 1138.2 1138.4 1149.1 11375.8 11524.0 11553.2 11587.1 11594.0 4593.2 4601.5 4795.0 4843.8 4853.0 10000.7 10002.5 10058.3 10074.7 10077.1 5347.5 5349.1 5366.5 5386.7 5397.5 4189.5 4733.1 4854.4 4874.6 4923.2 3916.4 3949.3 3991.8 4015.0 4076.7 1275.0 1305.5 1328.1 1335.6 1340.1 973.6 978.1 987.1 1005.1 1005.4 5746.8 5839.1 5903.8 5911.5 6013.4 941.1 953.4 957.9 976.8 992.8 4065.3 4124.9 4126.6 4128.5 4131.7 9884.1 10211.3 10308.2 10323.7 10327.1 10364.4 10542.6 10544.8 10554.3 10557.5 7493.2 7704.9 7720.2 7786.3 7892.1 5664.5 5831.5 5912.1 5953.5 6034.2 9398.4 9495.3 9563.4 9569.9 9699.3 9219.2 9632.3 9751.5 9856.0 9870.2 7299.7 7436.6 7511.1 7518.7 7521.8 7817.3 7819.3 7847.9 8087.5 8153.1 7139.3 7381.5 7481.1 7565.8 7581.7 7182.2 7306.7 7308.0 7345.2 7389.9 6912.7 6961.7 6981.3 6989.2 6997.9 5017.6 5038.8 5053.9 5155.1 5160.9 4968.3 5094.0 5102.8 5126.6 5272.5 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | [#4] prototype.html Cycles:180 Average:4953.90 Median:5635.68 stddev:1458.05 (25.9%) stddev-sans-first:1420.29 03:06:47 INFO - PROCESS | 31683 | Values: 333.1 337.5 345.3 352.7 353.6 5573.5 5605.9 5611.4 5642.2 5707.2 5561.2 5578.7 5584.7 5589.6 5590.2 3973.6 4096.9 4192.4 4283.7 4286.1 4275.7 4286.8 4293.2 4301.7 4303.4 4264.6 4265.2 4267.7 4270.0 4282.7 4065.6 4181.5 4276.7 4296.9 4320.0 3810.2 3815.3 3828.7 3830.2 3837.7 5301.8 5317.4 5320.9 5323.8 5350.8 4945.7 5039.1 5056.3 5059.4 5061.1 5845.9 5846.1 5877.9 5884.7 5903.7 4255.3 4267.7 4271.3 4274.2 4279.4 5778.9 5871.4 5882.3 6073.7 6101.6 4326.8 4364.2 4383.1 4385.3 4385.8 4413.6 4416.2 4419.8 4421.4 4424.4 4895.2 5002.7 5015.5 5017.8 5032.2 5835.9 5880.0 5883.6 5904.3 5917.3 1522.2 1524.3 1527.6 1532.6 1532.8 1012.5 1055.6 1056.3 1064.3 1065.3 5611.8 5629.2 5655.1 5663.1 5702.9 5979.3 5995.2 6020.5 6059.3 6066.7 5496.2 5697.8 5704.7 5719.5 5726.7 3167.4 3201.4 3205.6 3221.2 3231.8 6038.8 6190.4 6206.3 6207.8 6246.8 6056.4 6111.9 6128.3 6129.4 6145.7 6197.4 6223.8 6227.3 6228.6 6238.6 5811.4 5930.8 6022.1 6033.0 6059.8 5914.7 5922.1 5956.6 5969.7 5997.6 5988.8 6080.1 6286.8 6329.3 6340.9 4349.3 4377.1 4380.8 4388.3 4392.7 5863.7 6067.4 6132.6 6137.4 6158.6 5955.3 5967.6 5976.3 5989.1 6005.1 5950.6 5968.0 5970.6 5970.6 5983.9 5686.6 5880.9 5892.9 5895.8 5900.8 5950.7 5952.6 5968.5 6016.5 6032.9 5803.4 5911.5 5920.5 5921.4 5924.1 03:06:47 INFO - PROCESS | 31683 | 03:06:47 INFO - PROCESS | 31683 | [#5] yui.html Cycles:180 Average:14475.63 Median:4449.68 stddev:16880.39 (379.4%) stddev-sans-first:16896.35 03:06:47 INFO - PROCESS | 31683 | Values: 766.7 858.7 865.7 871.8 881.1 12867.3 13026.9 13029.2 13081.1 13208.0 11296.5 12969.9 13037.0 13040.8 13079.1 816.2 839.9 844.4 847.3 848.2 837.0 839.4 839.5 843.3 845.1 703.1 873.5 878.4 878.6 878.6 855.7 873.5 874.2 875.2 876.9 639.1 643.3 644.3 644.9 645.0 13397.2 13432.8 13502.1 13529.6 13532.7 14068.8 14235.1 14290.0 14299.6 14407.6 10580.8 10758.6 10797.2 10870.4 10928.6 3884.6 3896.7 3927.4 3929.8 3988.0 55250.7 55304.7 55475.2 55579.4 55675.0 10731.5 10996.9 11034.3 11050.0 11126.8 19243.5 19304.5 19327.8 19328.7 20400.0 7219.6 7925.8 8342.8 8370.4 8631.7 4561.9 4632.3 4674.4 4760.6 4831.5 3393.1 3495.4 3495.6 3500.5 3503.2 629.8 635.9 638.7 645.0 649.3 615.7 694.0 725.4 755.6 775.4 8601.1 8849.1 8905.2 8982.8 8999.3 643.9 724.3 771.7 774.4 795.3 4201.2 4427.6 4428.4 4471.0 4524.5 62386.4 62790.4 63196.4 64717.0 64906.0 53712.7 54316.5 54381.2 54941.0 55050.7 41662.6 42555.8 47757.8 48509.5 50365.7 8806.6 8862.8 9165.0 9210.4 9217.5 26632.9 30559.2 31168.5 31860.4 32109.8 40791.4 44917.3 45060.0 45071.1 45877.5 12033.7 12114.4 12150.2 12158.5 12210.2 11268.2 11781.4 12917.7 12953.9 12954.8 11813.6 12154.9 12271.4 12650.2 12800.4 11645.2 12266.7 12341.1 12832.7 12865.2 11814.7 11846.1 11865.2 12162.9 12385.1 10295.3 10315.4 10329.2 10591.6 10599.9 10471.9 10500.0 10532.8 10873.8 10930.8 03:06:47 INFO - PROCESS | 31683 | -------- Summary: end -------- 03:06:47 INFO - PROCESS | 31683 | 03:06:48 INFO - TEST-INFO | 31683: exit 0 03:06:48 INFO - TEST-OK | dromaeo_css | took 1111852ms 03:06:48 INFO - TEST-START | kraken 03:06:48 INFO - operating with platform_type : linux_ 03:06:48 INFO - Initialising browser for kraken test... 03:06:48 INFO - TEST-INFO | started process 31868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQzah0u/profile http://localhost:55437/getInfo.html) 03:06:52 INFO - PROCESS | 31868 | __metrics Screen width/height:1600/1200 03:06:52 INFO - PROCESS | 31868 | colorDepth:24 03:06:52 INFO - PROCESS | 31868 | Browser inner width/height: 1024/697 03:06:52 INFO - PROCESS | 31868 | __metrics 03:06:53 ERROR - PROCESS | 31868 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:06:54 INFO - TEST-INFO | 31868: exit 0 03:06:54 INFO - Browser initialized. 03:06:54 INFO - Running cycle 1/1 for kraken test... 03:06:54 INFO - TEST-INFO | started process 31948 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQzah0u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:06 INFO - PROCESS | 31948 | RSS: Main: 152621056 03:07:06 INFO - PROCESS | 31948 | 03:07:08 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55437/tests/kraken/driver.html?testName=audio-beat-detection) 03:07:09 INFO - PROCESS | 31948 | RSS: Main: 207630336 03:07:09 INFO - PROCESS | 31948 | 03:07:12 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55437/tests/kraken/driver.html?testName=audio-dft) 03:07:12 INFO - PROCESS | 31948 | RSS: Main: 193470464 03:07:12 INFO - PROCESS | 31948 | 03:07:16 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55437/tests/kraken/driver.html?testName=audio-fft) 03:07:16 INFO - PROCESS | 31948 | RSS: Main: 264597504 03:07:16 INFO - PROCESS | 31948 | 03:07:18 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55437/tests/kraken/driver.html?testName=audio-oscillator) 03:07:19 INFO - PROCESS | 31948 | RSS: Main: 172912640 03:07:19 INFO - PROCESS | 31948 | 03:07:21 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:07:22 INFO - PROCESS | 31948 | RSS: Main: 177229824 03:07:22 INFO - PROCESS | 31948 | 03:07:25 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55437/tests/kraken/driver.html?testName=imaging-darkroom) 03:07:25 INFO - PROCESS | 31948 | RSS: Main: 213524480 03:07:25 INFO - PROCESS | 31948 | 03:07:28 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55437/tests/kraken/driver.html?testName=imaging-desaturate) 03:07:29 INFO - PROCESS | 31948 | RSS: Main: 213327872 03:07:29 INFO - PROCESS | 31948 | 03:07:32 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55437/tests/kraken/driver.html?testName=json-parse-financial) 03:07:32 INFO - PROCESS | 31948 | RSS: Main: 213950464 03:07:32 INFO - PROCESS | 31948 | 03:07:34 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:07:35 INFO - PROCESS | 31948 | RSS: Main: 199454720 03:07:35 INFO - PROCESS | 31948 | 03:07:36 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:07:37 INFO - PROCESS | 31948 | RSS: Main: 202452992 03:07:37 INFO - PROCESS | 31948 | 03:07:39 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:07:40 INFO - PROCESS | 31948 | RSS: Main: 217743360 03:07:40 INFO - PROCESS | 31948 | 03:07:42 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:07:43 INFO - PROCESS | 31948 | RSS: Main: 222371840 03:07:43 INFO - PROCESS | 31948 | 03:07:46 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:07:46 INFO - PROCESS | 31948 | RSS: Main: 217341952 03:07:46 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | Cycle 1(1): loaded http://localhost:55437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55437/tests/kraken/driver.html?testName=ai-astar) 03:07:48 INFO - PROCESS | 31948 | RSS: Main: 280346624 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | __start_tp_report 03:07:48 INFO - PROCESS | 31948 | _x_x_mozilla_page_load 03:07:48 INFO - PROCESS | 31948 | _x_x_mozilla_page_load_details 03:07:48 INFO - PROCESS | 31948 | |i|pagename|runs| 03:07:48 INFO - PROCESS | 31948 | |0;ai-astar;110;109;107;108;109;111;100;111;111;110 03:07:48 INFO - PROCESS | 31948 | |1;audio-beat-detection;161;127;154;191;136;166;160;128;181;127 03:07:48 INFO - PROCESS | 31948 | |2;audio-dft;161;166;160;161;161;162;159;163;161;161 03:07:48 INFO - PROCESS | 31948 | |3;audio-fft;77;73;104;113;77;72;73;109;101;74 03:07:48 INFO - PROCESS | 31948 | |4;audio-oscillator;93;94;155;93;93;93;144;93;93;146 03:07:48 INFO - PROCESS | 31948 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;117;116 03:07:48 INFO - PROCESS | 31948 | |6;imaging-darkroom;145;146;145;145;144;146;145;145;145;144 03:07:48 INFO - PROCESS | 31948 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 03:07:48 INFO - PROCESS | 31948 | |8;json-parse-financial;58;58;56;56;56;65;57;76;56;55 03:07:48 INFO - PROCESS | 31948 | |9;json-stringify-tinderbox;61;61;60;61;61;61;64;62;61;64 03:07:48 INFO - PROCESS | 31948 | |10;stanford-crypto-aes;81;81;81;89;81;82;82;81;82;83 03:07:48 INFO - PROCESS | 31948 | |11;stanford-crypto-ccm;129;129;134;127;125;139;129;138;167;136 03:07:48 INFO - PROCESS | 31948 | |12;stanford-crypto-pbkdf2;167;166;170;165;170;167;168;164;171;165 03:07:48 INFO - PROCESS | 31948 | |13;stanford-crypto-sha256-iterative;69;68;67;69;69;68;69;68;68;66 03:07:48 INFO - PROCESS | 31948 | __end_tp_report 03:07:48 INFO - PROCESS | 31948 | __start_cc_report 03:07:48 INFO - PROCESS | 31948 | _x_x_mozilla_cycle_collect,1587 03:07:48 INFO - PROCESS | 31948 | __end_cc_report 03:07:48 INFO - PROCESS | 31948 | __startTimestamp1460628468661__endTimestamp 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | ------- Summary: start ------- 03:07:48 INFO - PROCESS | 31948 | Number of tests: 14 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.31 (3.0%) stddev-sans-first:3.47 03:07:48 INFO - PROCESS | 31948 | Values: 110.0 109.0 107.0 108.0 109.0 111.0 100.0 111.0 111.0 110.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:160.50 stddev:23.04 (14.4%) stddev-sans-first:24.26 03:07:48 INFO - PROCESS | 31948 | Values: 161.0 127.0 154.0 191.0 136.0 166.0 160.0 128.0 181.0 127.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 03:07:48 INFO - PROCESS | 31948 | Values: 161.0 166.0 160.0 161.0 161.0 162.0 159.0 163.0 161.0 161.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#3] audio-fft Cycles:10 Average:87.30 Median:73.00 stddev:17.09 (23.4%) stddev-sans-first:17.72 03:07:48 INFO - PROCESS | 31948 | Values: 77.0 73.0 104.0 113.0 77.0 72.0 73.0 109.0 101.0 74.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.00 stddev:26.80 (28.8%) stddev-sans-first:27.74 03:07:48 INFO - PROCESS | 31948 | Values: 93.0 94.0 155.0 93.0 93.0 93.0 144.0 93.0 93.0 146.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:07:48 INFO - PROCESS | 31948 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:07:48 INFO - PROCESS | 31948 | Values: 145.0 146.0 145.0 145.0 144.0 146.0 145.0 145.0 145.0 144.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:07:48 INFO - PROCESS | 31948 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.50 stddev:6.52 (11.3%) stddev-sans-first:6.89 03:07:48 INFO - PROCESS | 31948 | Values: 58.0 58.0 56.0 56.0 56.0 65.0 57.0 76.0 56.0 55.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.35 (2.2%) stddev-sans-first:1.41 03:07:48 INFO - PROCESS | 31948 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 64.0 62.0 61.0 64.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.45 (3.0%) stddev-sans-first:2.55 03:07:48 INFO - PROCESS | 31948 | Values: 81.0 81.0 81.0 89.0 81.0 82.0 82.0 81.0 82.0 83.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:135.00 stddev:12.12 (9.0%) stddev-sans-first:12.64 03:07:48 INFO - PROCESS | 31948 | Values: 129.0 129.0 134.0 127.0 125.0 139.0 129.0 138.0 167.0 136.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.50 stddev:2.41 (1.4%) stddev-sans-first:2.55 03:07:48 INFO - PROCESS | 31948 | Values: 167.0 166.0 170.0 165.0 170.0 167.0 168.0 164.0 171.0 165.0 03:07:48 INFO - PROCESS | 31948 | 03:07:48 INFO - PROCESS | 31948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 03:07:48 INFO - PROCESS | 31948 | Values: 69.0 68.0 67.0 69.0 69.0 68.0 69.0 68.0 68.0 66.0 03:07:48 INFO - PROCESS | 31948 | -------- Summary: end -------- 03:07:48 INFO - PROCESS | 31948 | 03:07:49 INFO - TEST-INFO | 31948: exit 0 03:07:49 INFO - TEST-OK | kraken | took 61284ms 03:07:49 INFO - SUITE-END | took 1173s 03:07:49 INFO - Completed test suite (00:19:33) 03:07:49 INFO - javascript benchmark 03:07:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.7487401007916, 3163.6203655561335, 3191.1064901827494, 3222.7099561039518, 3252.0, 5255.1329030709985, 5369.087255166622, 5379.67721936684, 5406.83779486615, 5470.343558772948, 5406.945930540694, 5442.401335853053, 5453.672779633225, 5454.4545545445435, 5472.179173124024, 4795.592374648159, 4856.368672072635, 4967.50324967504, 5012.548870601645, 5040.6471546991725, 4789.497102804207, 4938.432080310757, 4966.404031516205, 4995.175795993657, 5035.093683137034, 4856.708597484145, 4885.902281954359, 4931.482194369593, 4937.6049916007, 4953.529414705633, 4922.581580565657, 4928.67963582366, 4932.0, 4956.702597844141, 4972.378452693413, 4754.595859351959, 4855.271709243606, 4873.6832105913, 4882.707037577757, 4932.161532539477, 5316.096263635152, 5355.116405793039, 5361.035013697533, 5369.570434365241, 5391.81128660499, 5810.82567522975, 5812.041013232812, 5839.036558967765, 5841.591088623798, 5845.649261044308, 5703.31560212773, 5853.209816674737, 5876.7355469004, 5891.941080589225, 5942.5840191186635, 5483.067878460672, 5484.424135465799, 5487.533559647435, 5492.368377636543, 5517.44825517445, 5993.0, 5994.820155395345, 5996.340402555716, 5996.820095397145, 6000.669963151981, 5504.504594586427, 5744.224529688522, 5752.654840709571, 5800.767969281266, 5848.1227815827115, 5783.71081445926, 5784.074548072288, 5791.131330300404, 5792.652440853562, 5792.913106303409, 5759.452851979139, 5763.798267060716, 5765.538756899438, 5767.192593036978, 5769.711514424262, 5618.719064046782, 5820.330661973842, 5850.678212698343, 5873.911891321633, 5897.941020589825, 4355.412019377343, 4375.256206444912, 4381.78091095444, 4385.583369579885, 4413.22768515515, 3817.0457385653585, 3924.6467817895955, 3944.4674968878835, 3965.365541513344, 3985.7608543487486, 5468.808591699271, 5497.0, 5518.613697041169, 5559.027170245272, 5567.66594004361, 5869.178315035899, 5894.528437724972, 5905.586608937333, 5905.734241959036, 5906.40935906406, 5298.523132917979, 5497.45025497447, 5533.059379905426, 5546.389897111315, 5554.361248456479, 4861.732604706775, 4862.82980095702, 4863.221884498464, 4869.829555965524, 4909.803607855646, 6026.789062382795, 6027.969860150759, 6029.728662210211, 6030.487408570233, 6032.668203248863, 5667.121596152603, 5838.357780644041, 5859.179714840011, 5920.79277225295, 5940.910886336795, 5951.940480595312, 5956.821295361146, 5957.761689532544, 5958.791442299672, 5978.432048955342, 5654.236678048411, 5657.971710141423, 5661.0, 5672.971635141798, 5679.261695979496, 5670.5180059695385, 5774.653520788766, 5848.181254624441, 5918.201042859331, 5945.524358051259, 5685.744141513559, 5686.289213848269, 5697.4587414195585, 5697.6296540724725, 5699.544036477155, 5621.156826476062, 5670.234518339971, 5675.858103547444, 5677.148427735708, 5679.0, 5467.781288748405, 5630.8029218977135, 5686.800961966312, 5710.486056254957, 5740.483356497935, 5718.942810572007, 5721.828345149652, 5748.885022299614, 5750.194972703741, 5752.511036561939, 5428.647137936022, 5625.128105143709, 5626.43735626434, 5627.634203776742, 5668.801591944262], "value": 5351.589228227495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.837503873954, 637.9744810207592, 649.1269242868341, 658.8912829383154, 672.4250765595413, 30887.227819304528, 31732.841335793346, 31844.20389490264, 31915.521267180982, 37373.0, 40266.39600405996, 40536.189276214456, 40537.59462405375, 41018.58981410193, 41218.58781412185, 8560.614772335228, 8776.166264204921, 8784.64861405543, 8788.604512796908, 8794.912050879506, 8556.572171391437, 8654.177853103945, 8655.913440865574, 8694.652213911468, 8702.086280940504, 8629.95685021574, 8877.644894204224, 8880.289576833839, 8893.733188004338, 8906.287497000258, 8753.999999999936, 8754.168354006359, 8761.474311541297, 8762.693305734301, 8788.34087443441, 8744.825103497958, 8827.955860220722, 8834.0, 8837.027926928033, 8859.911400886038, 40964.0, 41405.37891931624, 41499.377509337384, 41678.37482437766, 41685.166296673895, 3416.8633254669785, 3455.6198818129988, 3637.6180501047274, 3688.7786732796117, 4093.8741845992295, 31035.0, 32126.0, 32171.19572010695, 32265.838670806497, 32271.193220169447, 4279.978600107011, 4384.430024096879, 4388.0, 4388.802503887333, 4430.26900561407, 290440.0, 291781.0, 292192.0, 293547.0, 294268.0, 58431.12353314704, 58457.70771146117, 58875.70562147162, 58876.70561647164, 58930.41069589335, 55138.448615514135, 64298.67850660717, 65586.34413655898, 66088.66955665287, 66194.35222591138, 17314.393996210325, 17827.910860445616, 17835.197416116305, 17871.0, 17890.463286101436, 13460.663483412796, 13593.320333983262, 13670.794938075738, 13673.726525469436, 13681.0, 19584.8041519583, 19996.700049499268, 20044.398668039692, 20079.196832126843, 20131.597368052557, 7139.178994415604, 7146.78065295773, 7350.686067362901, 7407.962960185272, 7482.6632801524065, 1031.8761748590066, 1048.4128887822844, 1079.4017485511777, 1136.5056200552622, 1251.9687007824878, 32587.34825303528, 33047.50428743571, 33156.1710957228, 33505.329893402, 33845.0, 1101.8292164714483, 1140.680609429361, 1164.7612239490884, 1197.6167626359481, 1200.1299058182922, 17214.827851721322, 17665.763396562117, 17666.470005899842, 17709.557261068578, 17721.468355949342, 437824.0, 441555.0, 442035.0, 442803.0, 443786.0, 59071.70464147738, 59456.0, 60081.0, 60217.09674354888, 60235.69882150561, 1224.8591411987736, 1401.7336706025822, 1402.5371627362742, 1423.6013916103507, 1427.4789701758991, 28591.14226573123, 30215.848920756136, 30716.539251911687, 30758.231044224074, 31422.0, 47023.0, 47201.29198061963, 47477.76261118672, 47499.76250118727, 47514.52485475101, 279583.0, 281738.0, 281793.0, 281917.0, 283027.0, 26173.345666358495, 28195.0, 28280.71719282863, 28810.7118928808, 29210.0, 41469.79265103655, 41533.79233103936, 41937.79031104825, 42740.358894617224, 42889.0, 35982.0, 39006.0, 39441.0, 39737.80131099326, 39773.40339894846, 39075.0, 39141.804290979504, 39323.0, 39706.40440393454, 39719.40420893747, 40211.195776084896, 41038.17923641451, 41165.382519262836, 41429.79285103555, 41470.1705965873, 34189.14527136841, 34800.30399391947, 35459.290814183056, 35691.46462803008, 35764.4635330465, 27164.72835271701, 27259.633231865293, 27416.0, 27429.45141097207, 27817.165485035483], "value": 19523.1107544509, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.8670495384046, 399.54451924805727, 399.65629558579633, 402.26385714143123, 402.7241339682318, 18116.90941545292, 18443.631127377444, 18751.3437029704, 18811.529711757197, 19583.0, 18652.813471865276, 18754.718679219823, 19063.52341191471, 19830.0, 19865.900670496663, 5533.170024496318, 5534.363548191969, 5552.250446189773, 5562.610617256793, 5695.03184458643, 5485.424030476803, 5644.8306550803545, 5651.06757385031, 5672.744726487318, 5685.431456854323, 5423.7830486780485, 5616.269884914956, 5617.4382561743705, 5617.578681598897, 5632.35227948787, 5570.637908535952, 5606.467385598362, 5611.438856114356, 5614.29821272341, 5624.437556244384, 4816.205326121186, 4919.975400122977, 4937.061958227925, 4950.455449900508, 4961.578265847371, 22341.0, 22389.888050559806, 22753.9961867591, 22989.310320690238, 23030.769692303198, 2221.9555608887895, 2289.9084036638515, 2338.580596263268, 2383.785459308653, 2408.987955060231, 14379.137251764927, 14473.0, 14494.637634059127, 14520.201388923604, 14803.555893323217, 1852.8610354223351, 1924.0668275886185, 1992.940211793634, 2007.3576455534235, 2069.9960519148203, 74779.62610186968, 86503.0, 91082.0, 95549.0, 98336.0, 16192.433264835674, 16771.413000544922, 17051.481357440287, 17589.12054397275, 17741.78227721535, 32396.190095247806, 32441.351172976407, 32772.34455310881, 32912.506312405334, 32944.505832412535, 10042.246831487668, 10164.0, 10253.794924101476, 10365.948170259251, 10483.633072842567, 8155.918440815634, 8277.089520152778, 8325.333973282122, 8411.285040771603, 8426.536540490331, 8681.739547813575, 8733.126687331343, 8783.560821958876, 8917.910820891708, 9064.138906803842, 3164.398764234788, 3248.2691394436065, 3309.0, 3408.6761757632985, 3475.2354482013916, 758.3629751009179, 905.5064989580694, 995.4326034160459, 1010.5957616953131, 1055.4775386183735, 18631.627367452846, 19173.90413047926, 19537.706934395996, 19639.803601964082, 19832.107555159764, 969.2972594868663, 979.4612962870393, 989.6303087985422, 1002.644061358222, 1113.2541197397763, 10566.76749144636, 10888.012012431489, 10974.451277436096, 10977.560897564008, 10979.066779323688, 454049.0, 457810.0, 458197.0, 458866.0, 479657.0, 71898.0, 85332.57333713291, 91565.0, 94509.0, 96627.51686241524, 1030.6032177611523, 1038.7351225437465, 1043.2905624175633, 1054.1882750282393, 1063.1494804156644, 16222.837771622133, 16814.159292035103, 17177.0, 17209.225584848962, 17288.222030008932, 36085.81957090198, 36470.4529432064, 37276.0, 37570.24859502849, 38292.61707382891, 48447.5155248443, 50092.499075010244, 51467.48532514627, 51945.0, 51961.0, 8608.870866937126, 8633.223009929137, 8728.607212675572, 8735.43219690718, 8799.164079412445, 9954.850677239992, 13386.732265354443, 13606.86393136056, 13746.65633359134, 13841.653958651113, 11822.408879555816, 11908.404579770804, 11985.580504682293, 12020.25706272603, 12091.214071085351, 11987.100967427303, 12017.399130043288, 12060.276383417024, 12174.878251217375, 12461.252324860538, 12154.513819447124, 12386.132970691964, 12435.440405181607, 12510.937445312715, 12545.93727031359, 7554.886676699744, 7847.607619619111, 7900.723474678359, 8004.079530854026, 8815.955920220358, 11524.711882203012, 11870.762584748429, 11927.76144477123, 12033.518659253532, 12359.32023738703], "value": 9901.68690462662, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.2755720575078, 1542.4755583101744, 1544.3590909772445, 1748.1346733366977, 1867.5237814357345, 8085.676572937083, 8447.197516235949, 8447.493150410979, 8462.703805366806, 8473.067962524117, 8240.381971352143, 8390.790230244247, 8395.83208335833, 8396.958015209932, 8405.705800296992, 2016.959660806783, 2071.585682863426, 2320.5938960681897, 2353.49399879026, 2395.832291739579, 2408.5544174327806, 2434.75652434756, 2441.0235905637796, 2442.584760590695, 2444.6210837320245, 2316.837821352506, 2343.4610039690883, 2344.5545346384133, 2346.671465994762, 2372.7627237276306, 1966.1349006437122, 2203.5262418580082, 2267.716535433071, 2268.5009297954507, 2284.3603790938564, 2230.7546169921297, 2252.6395776675818, 2252.831037672181, 2255.9774402256094, 2256.199049337494, 8195.549244791535, 8243.175682431769, 8249.958750206271, 8267.214614611603, 8273.420860539765, 4918.9754051229875, 5064.11378008847, 5067.898642027176, 5088.92366614501, 5099.031184075014, 3121.9687803121906, 3152.085895090421, 3248.5614442050255, 3250.2686895448574, 3270.6565810590023, 1113.3208742666966, 1115.341948250536, 1138.245446020632, 1138.3852719531444, 1149.074994629323, 11375.772484550263, 11523.96284334414, 11553.24903881245, 11587.130965177561, 11594.0, 4593.150267200579, 4601.493835678073, 4795.040991801654, 4843.806247750051, 4852.961756062462, 10000.699979000641, 10002.499875006366, 10058.295919285727, 10074.74813129663, 10077.143442807297, 5347.545458635982, 5349.090654588729, 5366.517013468807, 5386.67679939197, 5397.514223719884, 4189.476315460567, 4733.148033354029, 4854.393200849894, 4874.561289483963, 4923.187674033816, 3916.3929590913453, 3949.30887094763, 3991.7604943703473, 4014.979925100414, 4076.6534844538546, 1274.9681257968439, 1305.4973835073565, 1328.0637150808657, 1335.6460537957448, 1340.1088276296155, 973.5667627905514, 978.0854900667898, 987.1165307050294, 1005.1205195453978, 1005.3612611443301, 5746.798862039892, 5839.0949402842625, 5903.76384944606, 5911.4975227105315, 6013.398660133952, 941.1012483078644, 953.3564843730454, 957.8658987741721, 976.8192884316425, 992.831218692824, 4065.329220678614, 4124.8556300529335, 4126.607972242632, 4128.525219599725, 4131.669466442678, 9884.11043006133, 10211.336263142872, 10308.226882983807, 10323.741906452398, 10327.070563649308, 10364.429956352322, 10542.631007914839, 10544.789104217873, 10554.261201715959, 10557.47212639365, 7493.213212612706, 7704.8844267336035, 7720.189380115119, 7786.299233069051, 7892.0529536456, 5664.518515926027, 5831.533477321719, 5912.083627037816, 5953.464188223081, 6034.155218269533, 9398.436093834393, 9495.287853410884, 9563.426194428357, 9569.904300956901, 9699.272554558578, 9219.216366608645, 9632.325737198329, 9751.51242437861, 9855.950720246354, 9870.210383169473, 7299.708011679686, 7436.590987495523, 7511.06111736033, 7518.699252029857, 7521.7743467696055, 7817.296443320129, 7819.257170568787, 7847.9215207849475, 8087.47431416956, 8153.103158652425, 7139.286071392819, 7381.483296169216, 7481.10226772769, 7565.773026809205, 7581.734639287599, 7182.245864184394, 7306.744263950736, 7307.963460182665, 7345.22875098107, 7389.852202956018, 6912.654367281515, 6961.6519174042105, 6981.336773006759, 6989.196242431982, 6997.930020699728, 5017.648764586444, 5038.823641172541, 5053.949460505495, 5155.149400348901, 5160.922586161286, 4968.2795994579865, 5093.974530127326, 5102.846914592568, 5126.615503837153, 5272.472752724697], "value": 4546.102662175486, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.11391698083094, 337.5156650206952, 345.2508057515192, 352.698442831379, 353.56688057130003, 5573.47052030057, 5605.859853503664, 5611.382747897728, 5642.15367694846, 5707.172459993309, 5561.165825126233, 5578.665280083198, 5584.748686309115, 5589.580781441398, 5590.217369568264, 3973.6308511353895, 4096.873359826041, 4192.392103145042, 4283.736297792158, 4286.0999190170105, 4275.700700950934, 4286.76422796746, 4293.248681480744, 4301.741895486265, 4303.397524346594, 4264.616184543391, 4265.168292183025, 4267.658587313023, 4270.0, 4282.721623094504, 4065.6137666921745, 4181.477315335598, 4276.657867370634, 4296.914061718748, 4320.0, 3810.1998580297895, 3815.294170578424, 3828.712846536521, 3830.2148059647707, 3837.7313588048846, 5301.814436494704, 5317.41508434072, 5320.920186197211, 5323.813666521692, 5350.8127215547265, 4945.678530895516, 5039.143345631252, 5056.317397151374, 5059.418166910778, 5061.139606266944, 5845.85385365365, 5846.123081537761, 5877.9412205877825, 5884.735186916599, 5903.675297858616, 4255.255330317182, 4267.722598031118, 4271.252530807127, 4274.2092712848225, 4279.40088387626, 5778.855528611776, 5871.412858714137, 5882.264716910429, 6073.726682299307, 6101.633901965852, 4326.805293761789, 4364.192624364503, 4383.07955329378, 4385.276429389115, 4385.780710964439, 4413.558644135625, 4416.183006143874, 4419.801108950105, 4421.358902959053, 4424.358468022118, 4895.167821470359, 5002.674826136289, 5015.498450154955, 5017.8243761468175, 5032.194848824171, 5835.912461312999, 5880.0003999320215, 5883.61756485827, 5904.321003084614, 5917.260342457193, 1522.208451605159, 1524.336913442656, 1527.6486408126193, 1532.6091846579275, 1532.8160620725585, 1012.5342342522522, 1055.5566662001977, 1056.3028401255135, 1064.2762921213493, 1065.2649671726638, 5611.80358687444, 5629.211910332557, 5655.123455864347, 5663.093904975184, 5702.942970570241, 5979.279427860313, 5995.160677505153, 6020.518358531307, 6059.272887253558, 6066.726997285133, 5496.1755736639825, 5697.829065128053, 5704.686242256716, 5719.5138413235345, 5726.713664316768, 3167.4140284047526, 3201.439748044083, 3205.599300087489, 3221.2269055426527, 3231.757618178646, 6038.818835434944, 6190.380961903774, 6206.255249370014, 6207.844803879939, 6246.843828904223, 6056.394360563909, 6111.877762444727, 6128.295246046761, 6129.387061293835, 6145.692715364214, 6197.380261973857, 6223.844403889939, 6227.346128656516, 6228.5951413158, 6238.563300569007, 5811.389804070681, 5930.762769489172, 6022.09668549721, 6033.0, 6059.818205453844, 5914.658218106756, 5922.111683247547, 5956.583039187389, 5969.701514924323, 5997.570983751588, 5988.760449582142, 6080.148779171008, 6286.811395658137, 6329.30377658448, 6340.9048864268, 4349.3475978603465, 4377.10269394767, 4380.824767009284, 4388.341748737587, 4392.6705497087205, 5863.73613187399, 6067.362926892789, 6132.601380910227, 6137.35557766446, 6158.6304821709045, 5955.315138759098, 5967.582269241285, 5976.312724036791, 5989.101634754822, 6005.099235114768, 5950.553708471795, 5968.0, 5970.58205925581, 5970.582059255984, 5983.880322393615, 5686.601937864475, 5880.94119058804, 5892.852678682896, 5895.793647222326, 5900.763969441346, 5950.702464876826, 5952.5833191676165, 5968.522518198447, 6016.458518733335, 6032.8793424132145, 5803.390643982321, 5911.527077833849, 5920.467157955804, 5921.3782552831335, 5924.140999555127], "value": 4491.322443656483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.7086507127291, 858.742377286814, 865.7143142762889, 871.8212766382889, 881.1056777370969, 12867.292298923556, 13026.934865325684, 13029.153105048177, 13081.084324097317, 13208.0, 11296.548138074468, 12969.870301296984, 13037.0, 13040.804387934164, 13079.149855259402, 816.2490508731951, 839.9076101628816, 844.4173520271024, 847.3052097280232, 848.1560846957286, 836.995815020924, 839.3704721458906, 839.5382539603224, 843.2874221283006, 845.0830848529353, 703.1456780012284, 873.52829472085, 878.44218920985, 878.565110270417, 878.6134100995573, 855.6962278391175, 873.5195642396689, 874.2306770042322, 875.2166810704448, 876.8509353409904, 639.0956796133465, 643.2955913274957, 644.2591020326615, 644.9161608990848, 644.9903251451232, 13397.19616822984, 13432.798508022388, 13502.122362046435, 13529.59411217665, 13532.661683457894, 14068.788968165485, 14235.074720143157, 14290.0, 14299.57101286963, 14407.567772966722, 10580.841287380696, 10758.623448179354, 10797.190210734227, 10870.402127882964, 10928.617498387519, 3884.5532763731967, 3896.7077469189926, 3927.3912543555793, 3929.8035098244973, 3988.0029992501873, 55250.723746381416, 55304.72347638236, 55475.16787248194, 55579.44420555783, 55675.0, 10731.517081731341, 10996.890031099747, 11034.282771619979, 11050.0, 11126.777464450666, 19243.51891202703, 19304.517387065436, 19327.8067219326, 19328.71006934897, 20400.0, 7219.639018049076, 7925.762227133196, 8342.833143337099, 8370.372222083368, 8631.741047768577, 4561.908761824745, 4632.305154226893, 4674.439067311944, 4760.571548560646, 4831.4685384607665, 3393.0669066007044, 3495.4232551629207, 3495.615482296945, 3500.5099286099967, 3503.159241781954, 629.7795771480037, 635.9427651511386, 638.6998110887876, 644.9645269510128, 649.3279455763262, 615.673692942741, 693.9880916821021, 725.3906718356606, 755.6184127015932, 775.3835700618022, 8601.096884827128, 8849.115088491099, 8905.198532132139, 8982.820343593092, 8999.32505062123, 643.9162908821917, 724.3336130759714, 771.7106085218044, 774.3843644302793, 795.3120550723582, 4201.2017716633745, 4427.579379958899, 4428.3800267962515, 4470.977645111819, 4524.479684836286, 62386.37613623896, 62790.37209627937, 63196.36803631905, 64717.0, 64906.0, 53712.73143634257, 54316.45683543193, 54381.1842822358, 54941.0, 55050.724746376814, 41662.583374166476, 42555.7872210637, 47757.76121119303, 48509.5149048512, 50365.74817125891, 8806.603702833516, 8862.822743545223, 9165.0, 9210.401323913924, 9217.539123043687, 26632.866835665696, 30559.2360190997, 31168.532472012485, 31860.362792743552, 32109.839450802596, 40791.38812917868, 44917.326240107075, 45060.0, 45071.09857802891, 45877.54122458733, 12033.699157521132, 12114.394280285775, 12150.21023633461, 12158.513659453876, 12210.206336588093, 11268.15488838324, 11781.410929453321, 12917.741645167232, 12953.935230323788, 12954.80567791465, 11813.645590632295, 12154.939225303817, 12271.447784849524, 12650.177738446971, 12800.423980921067, 11645.243059201124, 12266.693332666755, 12341.136120471481, 12832.679183020498, 12865.228086314852, 11814.704632384259, 11846.11154163424, 11865.169438139248, 12162.939185304016, 12385.071119666241, 10295.330803497749, 10315.381077135396, 10329.225308101772, 10591.576336946437, 10599.947000264949, 10471.94764026175, 10499.965300841872, 10532.842007370049, 10873.782524349626, 10930.781384372109], "value": 6675.244094594872, "unit": "score"}], "name": "dromaeo_css", "value": 7214.576225797981, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 107.0, 108.0, 109.0, 111.0, 100.0, 111.0, 111.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 154.0, 191.0, 136.0, 166.0, 160.0, 128.0, 181.0, 127.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 160.0, 161.0, 161.0, 162.0, 159.0, 163.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 104.0, 113.0, 77.0, 72.0, 73.0, 109.0, 101.0, 74.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 155.0, 93.0, 93.0, 93.0, 144.0, 93.0, 93.0, 146.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 144.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 56.0, 56.0, 65.0, 57.0, 76.0, 56.0, 55.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 64.0, 62.0, 61.0, 64.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 89.0, 81.0, 82.0, 82.0, 81.0, 82.0, 83.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 134.0, 127.0, 125.0, 139.0, 129.0, 138.0, 167.0, 136.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 170.0, 165.0, 170.0, 167.0, 168.0, 164.0, 171.0, 165.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1550.8999999999999, "alertThreshold": 2.0}]} 03:07:49 INFO - Return code: 0 03:07:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:07:49 ERROR - # TBPL SUCCESS # 03:07:49 INFO - Running post-action listener: _resource_record_post_action 03:07:49 INFO - Running post-run listener: _resource_record_post_run 03:07:51 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 534654976; Read time: 0; Write time: 484964 03:07:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243699712; Read time: 0; Write time: 258160 03:07:51 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290955264; Read time: 0; Write time: 226804 03:07:51 INFO - Running post-run listener: _upload_blobber_files 03:07:51 INFO - Blob upload gear active. 03:07:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:07:51 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 03:07:51 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'] 03:07:51 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 03:07:51 INFO - (blobuploader) - INFO - Open directory for files ... 03:07:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 03:07:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:07:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:52 INFO - (blobuploader) - INFO - Done attempting. 03:07:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:07:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:07:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:53 INFO - (blobuploader) - INFO - Done attempting. 03:07:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:07:53 INFO - Return code: 0 03:07:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:07:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:07:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19d0488cde390f4d1b44f5fedd033bb6f2180919bb0f9db1187cb46251c55ce09af1b871dd4d0d717e1c484cdf33cf2d8f85b7be31fd199b26089448da1b80a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d367f1be6f499cb7789f25e64a7b92214bf8a0f3d22d6d8ec9d7c6a4545d91a5b6eaeb6a96d3de5d9f2ed8c86ca51a64b6c5e4ba50a2327b9307a942a9097"} 03:07:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:07:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:07:53 INFO - Contents: 03:07:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19d0488cde390f4d1b44f5fedd033bb6f2180919bb0f9db1187cb46251c55ce09af1b871dd4d0d717e1c484cdf33cf2d8f85b7be31fd199b26089448da1b80a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d367f1be6f499cb7789f25e64a7b92214bf8a0f3d22d6d8ec9d7c6a4545d91a5b6eaeb6a96d3de5d9f2ed8c86ca51a64b6c5e4ba50a2327b9307a942a9097"} 03:07:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:07:53 INFO - Copying logs to upload dir... 03:07:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:07:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.551331 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-14 03:07:52.789889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 03:07:52.793167) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 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/19d0488cde390f4d1b44f5fedd033bb6f2180919bb0f9db1187cb46251c55ce09af1b871dd4d0d717e1c484cdf33cf2d8f85b7be31fd199b26089448da1b80a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d367f1be6f499cb7789f25e64a7b92214bf8a0f3d22d6d8ec9d7c6a4545d91a5b6eaeb6a96d3de5d9f2ed8c86ca51a64b6c5e4ba50a2327b9307a942a9097"} build_url:https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/Sv96wPrMQZWmSlbiojwAJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19d0488cde390f4d1b44f5fedd033bb6f2180919bb0f9db1187cb46251c55ce09af1b871dd4d0d717e1c484cdf33cf2d8f85b7be31fd199b26089448da1b80a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d367f1be6f499cb7789f25e64a7b92214bf8a0f3d22d6d8ec9d7c6a4545d91a5b6eaeb6a96d3de5d9f2ed8c86ca51a64b6c5e4ba50a2327b9307a942a9097"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 03:07:52.817513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:07:52.817832) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1460626893.307485-292993076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:07:52.902623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 03:07:52.902948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 03:07:52.903247) ========= ========= Total master_lag: 0.28 =========