builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1457986221.93 results: success (0) buildid: 20160314103428 builduid: 51713045d2d34761809001124717e515 revision: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:21.933340) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:21.933792) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:21.934111) ========= 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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006556 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:21.964706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:21.965014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:21.979309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:21.979616) ========= 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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:22.029298) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:22.029603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:22.029979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:22.030308) ========= 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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 13:10:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-03-14 13:10:22 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162579 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:22.316669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:22.317028) ========= 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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016750 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:22.348453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 13:10:22.348806) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98dbd52b1b67eb85f4605b027ead33a3a847ce9a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98dbd52b1b67eb85f4605b027ead33a3a847ce9a --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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 13:10:22,700 truncating revision to first 12 chars 2016-03-14 13:10:22,700 Setting DEBUG logging. 2016-03-14 13:10:22,700 attempt 1/10 2016-03-14 13:10:22,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/98dbd52b1b67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 13:10:23,901 unpacking tar archive at: mozilla-aurora-98dbd52b1b67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.483239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 13:10:23.847380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:23.847774) ========= echo 98dbd52b1b67eb85f4605b027ead33a3a847ce9a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'98dbd52b1b67eb85f4605b027ead33a3a847ce9a'] 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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 98dbd52b1b67eb85f4605b027ead33a3a847ce9a program finished with exit code 0 elapsedTime=0.003911 script_repo_revision: '98dbd52b1b67eb85f4605b027ead33a3a847ce9a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:23.897491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:23.897855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 13:10:23.909114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-14 13:10:23.909461) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:10:24 INFO - MultiFileLogger online at 20160314 13:10:24 in /builds/slave/test-pgo 13:10:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:10:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:10:24 INFO - {'append_to_log': False, 13:10:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:10:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:10:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:10:24 INFO - 'branch': 'Mozilla-Aurora', 13:10:24 INFO - 'buildbot_json_path': 'buildprops.json', 13:10:24 INFO - 'config_files': ('talos/linux_config.py',), 13:10:24 INFO - 'default_actions': ('clobber', 13:10:24 INFO - 'read-buildbot-config', 13:10:24 INFO - 'download-and-extract', 13:10:24 INFO - 'populate-webroot', 13:10:24 INFO - 'create-virtualenv', 13:10:24 INFO - 'install', 13:10:24 INFO - 'run-tests'), 13:10:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:10:24 INFO - 'download_minidump_stackwalk': True, 13:10:24 INFO - 'download_symbols': 'ondemand', 13:10:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:10:24 INFO - 'tooltool.py': '/tools/tooltool.py', 13:10:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:10:24 INFO - '/tools/misc-python/virtualenv.py')}, 13:10:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:10:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:10:24 INFO - 'installer_path': 'installer.exe', 13:10:24 INFO - 'log_level': 'info', 13:10:24 INFO - 'log_name': 'talos', 13:10:24 INFO - 'log_to_console': True, 13:10:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:10:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:10:24 INFO - 'opt_config_files': (), 13:10:24 INFO - 'pip_index': False, 13:10:24 INFO - 'sps_profile': False, 13:10:24 INFO - 'sps_profile_interval': 0, 13:10:24 INFO - 'suite': 'dromaeojs', 13:10:24 INFO - 'system_bits': '32', 13:10:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:10:24 INFO - 'title': 'talos-linux64-ix-038', 13:10:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:10:24 INFO - 'use_talos_json': True, 13:10:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:10:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:10:24 INFO - 'work_dir': 'build'} 13:10:24 INFO - ##### 13:10:24 INFO - ##### Running clobber step. 13:10:24 INFO - ##### 13:10:24 INFO - Running pre-action listener: _resource_record_pre_action 13:10:24 INFO - Running main action method: clobber 13:10:24 INFO - rmtree: /builds/slave/test-pgo/build 13:10:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:10:24 INFO - Running post-action listener: _resource_record_post_action 13:10:24 INFO - ##### 13:10:24 INFO - ##### Running read-buildbot-config step. 13:10:24 INFO - ##### 13:10:24 INFO - Running pre-action listener: _resource_record_pre_action 13:10:24 INFO - Running main action method: read_buildbot_config 13:10:24 INFO - Using buildbot properties: 13:10:24 INFO - { 13:10:24 INFO - "project": "", 13:10:24 INFO - "product": "firefox", 13:10:24 INFO - "script_repo_revision": "production", 13:10:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:10:24 INFO - "repository": "", 13:10:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:10:24 INFO - "buildid": "20160314103428", 13:10:24 INFO - "pgo_build": "True", 13:10:24 INFO - "basedir": "/builds/slave/test-pgo", 13:10:24 INFO - "buildnumber": 106, 13:10:24 INFO - "slavename": "talos-linux64-ix-038", 13:10:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:10:24 INFO - "platform": "ubuntu64_hw", 13:10:24 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:10:24 INFO - "branch": "mozilla-aurora", 13:10:24 INFO - "repo_path": "releases/mozilla-aurora", 13:10:24 INFO - "revision": "98dbd52b1b67eb85f4605b027ead33a3a847ce9a", 13:10:24 INFO - "stage_platform": "linux64-pgo", 13:10:24 INFO - "builduid": "51713045d2d34761809001124717e515", 13:10:24 INFO - "slavebuilddir": "test" 13:10:24 INFO - } 13:10:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 13:10:24 INFO - Running post-action listener: _resource_record_post_action 13:10:24 INFO - ##### 13:10:24 INFO - ##### Running download-and-extract step. 13:10:24 INFO - ##### 13:10:24 INFO - Running pre-action listener: _resource_record_pre_action 13:10:24 INFO - Running main action method: download_and_extract 13:10:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:24 INFO - https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:10:25 INFO - Downloaded 1448 bytes. 13:10:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:10:25 INFO - Using the following test package requirements: 13:10:25 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 13:10:25 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:10:25 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:10:25 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'jsshell-linux-x86_64.zip'], 13:10:25 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:10:25 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 13:10:25 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:10:25 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:10:25 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:10:25 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 13:10:25 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:10:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:10:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:25 INFO - https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:10:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:10:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:10:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:10:27 INFO - Downloaded 23306124 bytes. 13:10:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:10:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:10:28 INFO - Return code: 0 13:10:28 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:28 INFO - https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:10:30 INFO - Downloaded 23306124 bytes. 13:10:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:10:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:10:31 INFO - Return code: 0 13:10: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')]} 13:10:31 INFO - https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 13:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 13:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 13:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:10:36 INFO - Downloaded 10845161 bytes. 13:10:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:10:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 13:10:37 INFO - Return code: 0 13:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:37 INFO - https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:10:43 INFO - Downloaded 60436636 bytes. 13:10:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:10:43 INFO - mkdir: /builds/slave/test-pgo/properties 13:10:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:10:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:10:43 INFO - Contents: 13:10:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:10:44 INFO - Running post-action listener: _resource_record_post_action 13:10:44 INFO - Running post-action listener: set_extra_try_arguments 13:10:44 INFO - ##### 13:10:44 INFO - ##### Running populate-webroot step. 13:10:44 INFO - ##### 13:10:44 INFO - Running pre-action listener: _resource_record_pre_action 13:10:44 INFO - Running main action method: populate_webroot 13:10:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:10:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:10:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:10:44 INFO - '--tppagecycles', 13:10:44 INFO - '7'], 13:10:44 INFO - 'tests': ['tsvgm']}}, 13:10:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:10:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:10:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:10:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:10:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:10:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'tests': ['damp', 'tps']}, 13:10:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['damp', 'tps']}, 13:10:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:10:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:10:44 INFO - 'other': {'tests': ['a11yr', 13:10:44 INFO - 'ts_paint', 13:10:44 INFO - 'tpaint', 13:10:44 INFO - 'sessionrestore', 13:10:44 INFO - 'sessionrestore_no_auto_restore', 13:10:44 INFO - 'tabpaint']}, 13:10:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['a11yr', 13:10:44 INFO - 'ts_paint', 13:10:44 INFO - 'tpaint', 13:10:44 INFO - 'sessionrestore', 13:10:44 INFO - 'sessionrestore_no_auto_restore', 13:10:44 INFO - 'tabpaint']}, 13:10:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['a11yr', 13:10:44 INFO - 'ts_paint', 13:10:44 INFO - 'tpaint', 13:10:44 INFO - 'sessionrestore', 13:10:44 INFO - 'sessionrestore_no_auto_restore', 13:10:44 INFO - 'tabpaint']}, 13:10:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['a11yr', 13:10:44 INFO - 'ts_paint', 13:10:44 INFO - 'tpaint', 13:10:44 INFO - 'sessionrestore', 13:10:44 INFO - 'sessionrestore_no_auto_restore', 13:10:44 INFO - 'tabpaint']}, 13:10:44 INFO - 'other_l64': {'tests': ['a11yr', 13:10:44 INFO - 'ts_paint', 13:10:44 INFO - 'tpaint', 13:10:44 INFO - 'sessionrestore', 13:10:44 INFO - 'sessionrestore_no_auto_restore', 13:10:44 INFO - 'tabpaint']}, 13:10:44 INFO - 'other_nol64': {'tests': ['a11yr', 13:10:44 INFO - 'ts_paint', 13:10:44 INFO - 'tpaint', 13:10:44 INFO - 'sessionrestore', 13:10:44 INFO - 'sessionrestore_no_auto_restore', 13:10:44 INFO - 'tabpaint']}, 13:10:44 INFO - 'svgr': {'tests': ['tsvgx', 13:10:44 INFO - 'tsvgr_opacity', 13:10:44 INFO - 'tart', 13:10:44 INFO - 'tscrollx', 13:10:44 INFO - 'cart']}, 13:10:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['tsvgx', 13:10:44 INFO - 'tsvgr_opacity', 13:10:44 INFO - 'tart', 13:10:44 INFO - 'tscrollx', 13:10:44 INFO - 'cart']}, 13:10:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'tests': ['tp5o']}, 13:10:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'talos_options': ['--e10s'], 13:10:44 INFO - 'tests': ['tp5o']}, 13:10:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'talos_options': ['--xperf_path', 13:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:44 INFO - 'tests': ['tp5n']}, 13:10:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:10:44 INFO - 'talos_options': ['--e10s', 13:10:44 INFO - '--xperf_path', 13:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:10:44 INFO - 'tests': ['tp5n']}}, 13:10:44 INFO - 'talos.zip': {'path': '', 13:10:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:10:44 INFO - Running post-action listener: _resource_record_post_action 13:10:44 INFO - ##### 13:10:44 INFO - ##### Running create-virtualenv step. 13:10:44 INFO - ##### 13:10:44 INFO - Running pre-action listener: _resource_record_pre_action 13:10:44 INFO - Running main action method: create_virtualenv 13:10:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:10:44 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 13:10:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:10:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:10:44 INFO - Using real prefix '/usr' 13:10:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:10:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:10:46 INFO - Installing pip.................done. 13:10:46 INFO - Return code: 0 13:10:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:46 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 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:10:46 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 13:10:46 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 13:10:46 INFO - Using env: {'DISPLAY': ':0', 13:10:46 INFO - 'HOME': '/home/cltbld', 13:10:46 INFO - 'LANG': 'en_US.UTF-8', 13:10:46 INFO - 'LANGUAGE': 'en_US:en', 13:10:46 INFO - 'LOGNAME': 'cltbld', 13:10:46 INFO - 'MAIL': '/var/mail/cltbld', 13:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:46 INFO - 'MOZ_NO_REMOTE': '1', 13:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:46 INFO - 'NO_EM_RESTART': '1', 13:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:10:46 INFO - 'PWD': '/builds/slave/test-pgo', 13:10:46 INFO - 'SHELL': '/bin/bash', 13:10:46 INFO - 'SHLVL': '1', 13:10:46 INFO - 'TERM': 'linux', 13:10:46 INFO - 'TMOUT': '86400', 13:10:46 INFO - 'USER': 'cltbld', 13:10:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:46 INFO - '_': '/tools/buildbot/bin/python'} 13:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:46 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 13:10:46 INFO - Cleaning up... 13:10:46 INFO - Return code: 0 13:10:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:46 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 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:10:46 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 13:10:46 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 13:10:46 INFO - Using env: {'DISPLAY': ':0', 13:10:46 INFO - 'HOME': '/home/cltbld', 13:10:46 INFO - 'LANG': 'en_US.UTF-8', 13:10:46 INFO - 'LANGUAGE': 'en_US:en', 13:10:46 INFO - 'LOGNAME': 'cltbld', 13:10:46 INFO - 'MAIL': '/var/mail/cltbld', 13:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:46 INFO - 'MOZ_NO_REMOTE': '1', 13:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:46 INFO - 'NO_EM_RESTART': '1', 13:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:10:46 INFO - 'PWD': '/builds/slave/test-pgo', 13:10:46 INFO - 'SHELL': '/bin/bash', 13:10:46 INFO - 'SHLVL': '1', 13:10:46 INFO - 'TERM': 'linux', 13:10:46 INFO - 'TMOUT': '86400', 13:10:46 INFO - 'USER': 'cltbld', 13:10:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:46 INFO - '_': '/tools/buildbot/bin/python'} 13:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:47 INFO - Downloading/unpacking psutil>=0.7.1 13:10:47 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 13:10:47 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 13:10:47 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 13:10:47 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 13:10:47 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 13:10:47 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 13:10:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:49 INFO - Installing collected packages: psutil 13:10:49 INFO - Running setup.py install for psutil 13:10:49 INFO - building 'psutil._psutil_linux' extension 13:10:49 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 13:10:49 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 13:10:49 INFO - building 'psutil._psutil_posix' extension 13:10:49 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 13:10:49 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 13:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:49 INFO - Successfully installed psutil 13:10:49 INFO - Cleaning up... 13:10:49 INFO - Return code: 0 13:10:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:10:49 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')]} 13:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:49 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')]} 13:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:49 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 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:10:49 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 13:10:49 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 13:10:49 INFO - Using env: {'DISPLAY': ':0', 13:10:49 INFO - 'HOME': '/home/cltbld', 13:10:49 INFO - 'LANG': 'en_US.UTF-8', 13:10:49 INFO - 'LANGUAGE': 'en_US:en', 13:10:49 INFO - 'LOGNAME': 'cltbld', 13:10:49 INFO - 'MAIL': '/var/mail/cltbld', 13:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:49 INFO - 'MOZ_NO_REMOTE': '1', 13:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:49 INFO - 'NO_EM_RESTART': '1', 13:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:10:49 INFO - 'PWD': '/builds/slave/test-pgo', 13:10:49 INFO - 'SHELL': '/bin/bash', 13:10:49 INFO - 'SHLVL': '1', 13:10:49 INFO - 'TERM': 'linux', 13:10:49 INFO - 'TMOUT': '86400', 13:10:49 INFO - 'USER': 'cltbld', 13:10:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:49 INFO - '_': '/tools/buildbot/bin/python'} 13:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:10:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:10:51 INFO - Installing collected packages: mozsystemmonitor 13:10:51 INFO - Running setup.py install for mozsystemmonitor 13:10:51 INFO - Successfully installed mozsystemmonitor 13:10:51 INFO - Cleaning up... 13:10:51 INFO - Return code: 0 13:10:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:10:51 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')]} 13:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:51 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')]} 13:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:51 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 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:10:51 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 13:10:51 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 13:10:51 INFO - Using env: {'DISPLAY': ':0', 13:10:51 INFO - 'HOME': '/home/cltbld', 13:10:51 INFO - 'LANG': 'en_US.UTF-8', 13:10:51 INFO - 'LANGUAGE': 'en_US:en', 13:10:51 INFO - 'LOGNAME': 'cltbld', 13:10:51 INFO - 'MAIL': '/var/mail/cltbld', 13:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:51 INFO - 'MOZ_NO_REMOTE': '1', 13:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:51 INFO - 'NO_EM_RESTART': '1', 13:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:10:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:10:51 INFO - 'SHELL': '/bin/bash', 13:10:51 INFO - 'SHLVL': '1', 13:10:51 INFO - 'TERM': 'linux', 13:10:51 INFO - 'TMOUT': '86400', 13:10:51 INFO - 'USER': 'cltbld', 13:10:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:51 INFO - '_': '/tools/buildbot/bin/python'} 13:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:10:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:10:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:10:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:54 INFO - Downloading docopt-0.6.1.tar.gz 13:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:10:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:10:54 INFO - Running setup.py install for blobuploader 13:10:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:10:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:10:54 INFO - Running setup.py install for requests 13:10:55 INFO - Running setup.py install for docopt 13:10:55 INFO - Successfully installed blobuploader requests docopt 13:10:55 INFO - Cleaning up... 13:10:55 INFO - Return code: 0 13:10:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:10: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')]} 13:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10: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')]} 13:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:10:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:10:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:55 INFO - Using env: {'DISPLAY': ':0', 13:10:55 INFO - 'HOME': '/home/cltbld', 13:10:55 INFO - 'LANG': 'en_US.UTF-8', 13:10:55 INFO - 'LANGUAGE': 'en_US:en', 13:10:55 INFO - 'LOGNAME': 'cltbld', 13:10:55 INFO - 'MAIL': '/var/mail/cltbld', 13:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:55 INFO - 'MOZ_NO_REMOTE': '1', 13:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:55 INFO - 'NO_EM_RESTART': '1', 13:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:10:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:10:55 INFO - 'SHELL': '/bin/bash', 13:10:55 INFO - 'SHLVL': '1', 13:10:55 INFO - 'TERM': 'linux', 13:10:55 INFO - 'TMOUT': '86400', 13:10:55 INFO - 'USER': 'cltbld', 13:10:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:55 INFO - '_': '/tools/buildbot/bin/python'} 13:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:10:55 INFO - Running setup.py (path:/tmp/pip-QBUS6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:10:55 INFO - Running setup.py (path:/tmp/pip-ir1v3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:10:55 INFO - Running setup.py (path:/tmp/pip-4zu8Uq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:10:55 INFO - Running setup.py (path:/tmp/pip-si4DCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:10:55 INFO - Running setup.py (path:/tmp/pip-0ZlbGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:10:55 INFO - Running setup.py (path:/tmp/pip-Z49dIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:10:55 INFO - Running setup.py (path:/tmp/pip-eEyQNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:10:55 INFO - Running setup.py (path:/tmp/pip-SGcWFx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:10:55 INFO - Running setup.py (path:/tmp/pip-lNXMTe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:10:56 INFO - Running setup.py (path:/tmp/pip-gnEy5p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:10:56 INFO - Running setup.py (path:/tmp/pip-8rguPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:10:56 INFO - Running setup.py (path:/tmp/pip-x31zCZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:10:56 INFO - Running setup.py (path:/tmp/pip-9nGtn4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:10:56 INFO - Running setup.py (path:/tmp/pip-wcnx_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:10:56 INFO - Running setup.py (path:/tmp/pip-MkuM42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:10:56 INFO - Running setup.py (path:/tmp/pip-aMMd6m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:10:56 INFO - Running setup.py (path:/tmp/pip-P1krue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:10:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:10:56 INFO - Running setup.py install for manifestparser 13:10:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:10:56 INFO - Running setup.py install for mozcrash 13:10:56 INFO - Running setup.py install for mozdebug 13:10:56 INFO - Running setup.py install for mozdevice 13:10:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Running setup.py install for mozfile 13:10:57 INFO - Running setup.py install for mozhttpd 13:10:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Running setup.py install for mozinfo 13:10:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Running setup.py install for mozInstall 13:10:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Running setup.py install for mozleak 13:10:57 INFO - Running setup.py install for mozlog 13:10:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Running setup.py install for moznetwork 13:10:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Running setup.py install for mozprocess 13:10:57 INFO - Running setup.py install for mozprofile 13:10:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:10:57 INFO - Running setup.py install for mozrunner 13:10:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:10:58 INFO - Running setup.py install for mozscreenshot 13:10:58 INFO - Running setup.py install for moztest 13:10:58 INFO - Running setup.py install for mozversion 13:10:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:10:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:10:58 INFO - Cleaning up... 13:10:58 INFO - Return code: 0 13:10:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:10:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:10:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:58 INFO - Using env: {'DISPLAY': ':0', 13:10:58 INFO - 'HOME': '/home/cltbld', 13:10:58 INFO - 'LANG': 'en_US.UTF-8', 13:10:58 INFO - 'LANGUAGE': 'en_US:en', 13:10:58 INFO - 'LOGNAME': 'cltbld', 13:10:58 INFO - 'MAIL': '/var/mail/cltbld', 13:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:58 INFO - 'MOZ_NO_REMOTE': '1', 13:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:58 INFO - 'NO_EM_RESTART': '1', 13:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:10:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:10:58 INFO - 'SHELL': '/bin/bash', 13:10:58 INFO - 'SHLVL': '1', 13:10:58 INFO - 'TERM': 'linux', 13:10:58 INFO - 'TMOUT': '86400', 13:10:58 INFO - 'USER': 'cltbld', 13:10:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:58 INFO - '_': '/tools/buildbot/bin/python'} 13:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:10:58 INFO - Running setup.py (path:/tmp/pip-ibAQoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:10:58 INFO - Running setup.py (path:/tmp/pip-VG6HHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:10:58 INFO - Running setup.py (path:/tmp/pip-ykUaNh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:10:58 INFO - Running setup.py (path:/tmp/pip-GheU_r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:10:58 INFO - Running setup.py (path:/tmp/pip-JDa6Jj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:10:58 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)) 13:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:10:58 INFO - Running setup.py (path:/tmp/pip-I9KfMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:10:59 INFO - Running setup.py (path:/tmp/pip-0z6pCV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:10:59 INFO - Running setup.py (path:/tmp/pip-hIydvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:10:59 INFO - Running setup.py (path:/tmp/pip-y4ZAL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:10:59 INFO - Running setup.py (path:/tmp/pip-SFiZ0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:10:59 INFO - Running setup.py (path:/tmp/pip-F9r3Lh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:10:59 INFO - Running setup.py (path:/tmp/pip-KB6Gbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:10:59 INFO - Running setup.py (path:/tmp/pip-C5xnMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:10:59 INFO - Running setup.py (path:/tmp/pip-Ot3NAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:10:59 INFO - Running setup.py (path:/tmp/pip-5UI2BT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:10:59 INFO - Running setup.py (path:/tmp/pip-_HBLXL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:10:59 INFO - Running setup.py (path:/tmp/pip-BkUjeP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:10:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:01 INFO - Downloading blessings-1.6.tar.gz 13:11:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:11:01 INFO - Installing collected packages: blessings 13:11:01 INFO - Running setup.py install for blessings 13:11:01 INFO - Successfully installed blessings 13:11:01 INFO - Cleaning up... 13:11:01 INFO - Return code: 0 13:11:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:11:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:11:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:11:02 INFO - Reading from file tmpfile_stdout 13:11:02 INFO - Current package versions: 13:11:02 INFO - argparse == 1.2.1 13:11:02 INFO - blessings == 1.6 13:11:02 INFO - blobuploader == 1.2.4 13:11:02 INFO - docopt == 0.6.1 13:11:02 INFO - manifestparser == 1.1 13:11:02 INFO - mozInstall == 1.12 13:11:02 INFO - mozcrash == 0.17 13:11:02 INFO - mozdebug == 0.1 13:11:02 INFO - mozdevice == 0.48 13:11:02 INFO - mozfile == 1.2 13:11:02 INFO - mozhttpd == 0.7 13:11:02 INFO - mozinfo == 0.9 13:11:02 INFO - mozleak == 0.1 13:11:02 INFO - mozlog == 3.1 13:11:02 INFO - moznetwork == 0.27 13:11:02 INFO - mozprocess == 0.22 13:11:02 INFO - mozprofile == 0.28 13:11:02 INFO - mozrunner == 6.11 13:11:02 INFO - mozscreenshot == 0.1 13:11:02 INFO - mozsystemmonitor == 0.0 13:11:02 INFO - moztest == 0.7 13:11:02 INFO - mozversion == 1.4 13:11:02 INFO - psutil == 3.1.1 13:11:02 INFO - requests == 1.2.3 13:11:02 INFO - wsgiref == 0.1.2 13:11:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:11:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:11:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:11:02 INFO - Using env: {'DISPLAY': ':0', 13:11:02 INFO - 'HOME': '/home/cltbld', 13:11:02 INFO - 'LANG': 'en_US.UTF-8', 13:11:02 INFO - 'LANGUAGE': 'en_US:en', 13:11:02 INFO - 'LOGNAME': 'cltbld', 13:11:02 INFO - 'MAIL': '/var/mail/cltbld', 13:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:02 INFO - 'MOZ_NO_REMOTE': '1', 13:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:02 INFO - 'NO_EM_RESTART': '1', 13:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:11:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:11:02 INFO - 'SHELL': '/bin/bash', 13:11:02 INFO - 'SHLVL': '1', 13:11:02 INFO - 'TERM': 'linux', 13:11:02 INFO - 'TMOUT': '86400', 13:11:02 INFO - 'USER': 'cltbld', 13:11:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:02 INFO - '_': '/tools/buildbot/bin/python'} 13:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:11:02 INFO - Cleaning up... 13:11:02 INFO - Return code: 0 13:11:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:11:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:11:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:11:02 INFO - Using env: {'DISPLAY': ':0', 13:11:02 INFO - 'HOME': '/home/cltbld', 13:11:02 INFO - 'LANG': 'en_US.UTF-8', 13:11:02 INFO - 'LANGUAGE': 'en_US:en', 13:11:02 INFO - 'LOGNAME': 'cltbld', 13:11:02 INFO - 'MAIL': '/var/mail/cltbld', 13:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:02 INFO - 'MOZ_NO_REMOTE': '1', 13:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:02 INFO - 'NO_EM_RESTART': '1', 13:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:11:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:11:02 INFO - 'SHELL': '/bin/bash', 13:11:02 INFO - 'SHLVL': '1', 13:11:02 INFO - 'TERM': 'linux', 13:11:02 INFO - 'TMOUT': '86400', 13:11:02 INFO - 'USER': 'cltbld', 13:11:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:02 INFO - '_': '/tools/buildbot/bin/python'} 13:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:02 INFO - Downloading/unpacking jsonschema 13:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:05 INFO - Downloading/unpacking functools32 (from jsonschema) 13:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:06 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:06 INFO - warning: no files found matching '*.txt' 13:11:06 INFO - no previously-included directories found matching 'build' 13:11:06 INFO - no previously-included directories found matching 'dist' 13:11:06 INFO - no previously-included directories found matching '.git*' 13:11:06 INFO - Installing collected packages: jsonschema, functools32 13:11:06 INFO - Running setup.py install for functools32 13:11:06 INFO - warning: no files found matching '*.txt' 13:11:06 INFO - no previously-included directories found matching 'build' 13:11:06 INFO - no previously-included directories found matching 'dist' 13:11:06 INFO - no previously-included directories found matching '.git*' 13:11:06 INFO - Successfully installed jsonschema functools32 13:11:06 INFO - Cleaning up... 13:11:06 INFO - Return code: 0 13:11:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:06 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 0x7fc5a9e90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, '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': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', '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 13:11:06 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 13:11:06 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 13:11:06 INFO - Using env: {'DISPLAY': ':0', 13:11:06 INFO - 'HOME': '/home/cltbld', 13:11:06 INFO - 'LANG': 'en_US.UTF-8', 13:11:06 INFO - 'LANGUAGE': 'en_US:en', 13:11:06 INFO - 'LOGNAME': 'cltbld', 13:11:06 INFO - 'MAIL': '/var/mail/cltbld', 13:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:06 INFO - 'MOZ_NO_REMOTE': '1', 13:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:06 INFO - 'NO_EM_RESTART': '1', 13:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:11:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:11:06 INFO - 'SHELL': '/bin/bash', 13:11:06 INFO - 'SHLVL': '1', 13:11:06 INFO - 'TERM': 'linux', 13:11:06 INFO - 'TMOUT': '86400', 13:11:06 INFO - 'USER': 'cltbld', 13:11:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:06 INFO - '_': '/tools/buildbot/bin/python'} 13:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:06 INFO - Downloading/unpacking flake8 13:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:11:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:11:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:09 INFO - no previously-included directories found matching 'docs/_build' 13:11:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:11:09 INFO - Running setup.py install for pep8 13:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:11:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:11:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:11:09 INFO - no previously-included directories found matching 'docs/_build' 13:11:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:11:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:11:09 INFO - Cleaning up... 13:11:09 INFO - Return code: 0 13:11:09 INFO - Running post-action listener: _resource_record_post_action 13:11:09 INFO - Running post-action listener: _start_resource_monitoring 13:11:09 INFO - Starting resource monitoring. 13:11:09 INFO - ##### 13:11:09 INFO - ##### Running install step. 13:11:09 INFO - ##### 13:11:09 INFO - Running pre-action listener: _resource_record_pre_action 13:11:09 INFO - Running main action method: install 13:11:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:11:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:11:09 INFO - Reading from file tmpfile_stdout 13:11:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:11:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:11:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:11:09 INFO - Reading from file tmpfile_stdout 13:11:09 INFO - Output received: 13:11:09 INFO - Usage: mozinstall [options] installer 13:11:09 INFO - Options: 13:11:09 INFO - -h, --help show this help message and exit 13:11:09 INFO - -d DEST, --destination=DEST 13:11:09 INFO - Directory to install application into. [default: 13:11:09 INFO - "/builds/slave/test-pgo"] 13:11:09 INFO - --app=APP Application being installed. [default: firefox] 13:11:09 INFO - mkdir: /builds/slave/test-pgo/build/application 13:11:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:11:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:11:25 INFO - Reading from file tmpfile_stdout 13:11:25 INFO - Output received: 13:11:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:11:25 INFO - Running post-action listener: _resource_record_post_action 13:11:25 INFO - ##### 13:11:25 INFO - ##### Running run-tests step. 13:11:25 INFO - ##### 13:11:25 INFO - Running pre-action listener: _resource_record_pre_action 13:11:25 INFO - Running main action method: run_tests 13:11:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:11:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:11:25 INFO - Python 2.7.3 13:11:25 INFO - Return code: 0 13:11:25 INFO - grabbing minidump binary from tooltool 13:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:25 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 0x2648920>, '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 0x2649820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:11:25 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 13:11:25 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 13:11:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:11:25 INFO - Return code: 0 13:11:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:11:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:11:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:11:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:11:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:11:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:11:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:11:26 INFO - Return code: 0 13:11:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 13:11:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 13:11:26 INFO - Using env: {'DISPLAY': ':0', 13:11:26 INFO - 'HOME': '/home/cltbld', 13:11:26 INFO - 'LANG': 'en_US.UTF-8', 13:11:26 INFO - 'LANGUAGE': 'en_US:en', 13:11:26 INFO - 'LOGNAME': 'cltbld', 13:11:26 INFO - 'MAIL': '/var/mail/cltbld', 13:11:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:11:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:26 INFO - 'MOZ_NO_REMOTE': '1', 13:11:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:26 INFO - 'NO_EM_RESTART': '1', 13:11:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:11:26 INFO - 'PWD': '/builds/slave/test-pgo', 13:11:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:11:26 INFO - 'SHELL': '/bin/bash', 13:11:26 INFO - 'SHLVL': '1', 13:11:26 INFO - 'TERM': 'linux', 13:11:26 INFO - 'TMOUT': '86400', 13:11:26 INFO - 'USER': 'cltbld', 13:11:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898', 13:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:26 INFO - '_': '/tools/buildbot/bin/python'} 13:11:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 13:11:26 INFO - mozversion application_buildid: 20160314103428 13:11:26 INFO - mozversion application_changeset: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a 13:11:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:11:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:11:26 INFO - mozversion application_name: Firefox 13:11:26 INFO - mozversion application_remotingname: firefox-dev 13:11:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:11:26 INFO - mozversion application_vendor: Mozilla 13:11:26 INFO - mozversion application_version: 47.0a2 13:11:26 INFO - mozversion platform_buildid: 20160314103428 13:11:26 INFO - mozversion platform_changeset: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a 13:11:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:11:26 INFO - mozversion platform_version: 47.0a2 13:11:26 INFO - using testdate: 1457986286 13:11:26 INFO - actual date: 1457986286 13:11:26 INFO - starting webserver on 'localhost:60603' 13:11:26 INFO - SUITE-START | Running 2 tests 13:11:26 INFO - TEST-START | dromaeo_css 13:11:26 INFO - operating with platform_type : linux_ 13:11:26 INFO - Initialising browser for dromaeo_css test... 13:11:26 INFO - TEST-INFO | started process 2020 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprgVs_2/profile http://localhost:60603/getInfo.html) 13:11:31 INFO - PROCESS | 2020 | __metrics Screen width/height:1600/1200 13:11:31 INFO - PROCESS | 2020 | colorDepth:24 13:11:31 INFO - PROCESS | 2020 | Browser inner width/height: 1024/697 13:11:31 INFO - PROCESS | 2020 | __metrics 13:11:32 INFO - PROCESS | 2020 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:11:33 INFO - TEST-INFO | 2020: exit 0 13:11:33 INFO - Browser initialized. 13:11:33 INFO - Running cycle 1/1 for dromaeo_css test... 13:11:33 INFO - TEST-INFO | started process 2112 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprgVs_2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:44 INFO - PROCESS | 2112 | RSS: Main: 144179200 13:11:44 INFO - PROCESS | 2112 | 13:12:36 INFO - PROCESS | 2112 | 1457986356153 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] 13:14:43 INFO - PROCESS | 2112 | Cycle 1(1): loaded http://localhost:60603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60603/tests/dromaeo/cssquery-ext.html) 13:14:44 INFO - PROCESS | 2112 | RSS: Main: 296828928 13:14:44 INFO - PROCESS | 2112 | 13:17:46 INFO - PROCESS | 2112 | Cycle 1(1): loaded http://localhost:60603/tests/dromaeo/cssquery-ext.html (next: http://localhost:60603/tests/dromaeo/cssquery-jquery.html) 13:17:47 INFO - PROCESS | 2112 | RSS: Main: 216985600 13:17:47 INFO - PROCESS | 2112 | 13:20:49 INFO - PROCESS | 2112 | Cycle 1(1): loaded http://localhost:60603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60603/tests/dromaeo/cssquery-mootools.html) 13:20:49 INFO - PROCESS | 2112 | RSS: Main: 208179200 13:20:49 INFO - PROCESS | 2112 | 13:23:51 INFO - PROCESS | 2112 | Cycle 1(1): loaded http://localhost:60603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60603/tests/dromaeo/cssquery-prototype.html) 13:23:52 INFO - PROCESS | 2112 | RSS: Main: 208179200 13:23:52 INFO - PROCESS | 2112 | 13:26:54 INFO - PROCESS | 2112 | Cycle 1(1): loaded http://localhost:60603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60603/tests/dromaeo/cssquery-yui.html) 13:26:55 INFO - PROCESS | 2112 | RSS: Main: 209764352 13:26:55 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | Cycle 1(1): loaded http://localhost:60603/tests/dromaeo/cssquery-yui.html (next: http://localhost:60603/tests/dromaeo/cssquery-dojo.html) 13:29:57 INFO - PROCESS | 2112 | RSS: Main: 258760704 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | __start_tp_report 13:29:57 INFO - PROCESS | 2112 | _x_x_mozilla_page_load 13:29:57 INFO - PROCESS | 2112 | _x_x_mozilla_page_load_details 13:29:57 INFO - PROCESS | 2112 | |i|pagename|runs| 13:29:57 INFO - PROCESS | 2112 | |0;dojo.html;3259.983700081499;3276.8361581920926;3291.1607540077293;3303.5209894565287;3319.41910165721;5256.132738098214;5269.051570717269;5280.630355875091;5280.973595132019;5346.198070289453;5264.341957255343;5288.444713305095;5296.682199068058;5309.973450132754;5332.760025798839;4812.0857037163005;4833.371661683985;4836.733979631119;4885.658003939726;4933.531314525115;4904.632152588552;5004.249362595621;5008.123578373788;5013.799448022075;5015.272785446108;4959.876003099934;5023.899522009558;5031.748412579374;5043.218301163325;5049.722265275408;4923.581495572845;4930.457649658535;5066.341375621146;5067.923981140304;5074.314967479399;4815.085133824562;4835.226363781813;4862.051899879525;4903.901921961577;4930.309756634074;5116.641835071547;5180.197069454203;5214.765335559909;5230.137027390476;5234.92147617786;5678.119891416837;5698.8290351289525;5701.515371193454;5705.971470142623;5743.712814359265;5687.744051517691;5740.827775166752;5745.626534275259;5748.48263656273;5767.567432442584;5444.156155795858;5460.017196904595;5481.698506582136;5484.095124304485;5511.118221084607;5966.970165149147;5994.430529099728;5997.340292567814;5998.490128339053;6001.159837622737;5654.575906807006;5702.6863522506665;5732.054211055212;5751.741171647286;5757.769689212469;5851.502622277069;5855.03391940325;5857;5862.443067908627;5865.530757539386;5807.5644326675665;5818.825435236865;5820.417958204231;5820.854478638068;5823.505002074871;5677.460641239076;5760.107183386582;5805.01314776489;5820.214271073351;5828.388019258002;4417.779111044435;4419.955800442019;4421.53573874745;4427.535108813592;4444.377787109807;4006.2788698034633;4008.599140086026;4023.6781057515327;4029.194161167778;4049.4128351388886;5205.531502164823;5391.460853914656;5435.157550579666;5474.808381706701;5478.643888147258;5771.394003629643;5809.709514524341;5819.068948968229;5838.241028666246;5842.824715258549;5156.716380599028;5387.272718182995;5427.3215848019;5434.972825135849;5436.266104075899;4934.062528119717;4967.925481117786;4975.825846095369;4987.950120498821;5004.899902001939;6022.728977196037;6058.848528786815;6070.150178974947;6093.66484843329;6097.603655762361;5711.7429715662065;5845.532357411482;5897.3807750187325;5905.084711869667;5913.46778789911;5904.940950590611;5914.378990206139;5915.201447804491;5915.70421478933;5926;5605.131204663284;5629.521490673339;5644.181593668977;5647.548196144381;5667.574931880208;5719.7426115824055;5751.683657398883;5772.913406298825;5812.21535092757;5817.418258174149;5743.770249189985;5750.13747937796;5757.0788673811985;5757.91363129545;5763;5727.083666613322;5755.3381361144;5755.827325180251;5762.5389968801555;5762.942370576408;5554.638948468337;5659.518940890071;5672.03575392176;5714.3714191438075;5742.942570574241;5641.830745077655;5642.238297829905;5692.373838877637;5710.942890571041;5716.714164291686;5302.893942121059;5385.569154467712;5386.757595908115;5428.945710543002;5435.048866448435 13:29:57 INFO - PROCESS | 2112 | |1;ext.html;523.2497612333485;561.7387914619703;571.5598988778638;574.695411431941;619.3806193806194;30737;31404.371912561735;31426.371472570536;31426.68573314266;31435.685643143563;39272.80363598185;39580.80209598948;39633.40549891754;39635.40546891792;39701.40447893284;8966.103389661046;9123.315751318678;9145.954270228673;9146.908530914705;9152.816943661122;8933.910660893405;9078.455292682427;9081.545922703872;9086.318526110535;9088.50013249271;9063.773405664846;9175.632974681004;9179.908200917973;9180.632774689004;9180.6786762463;9006.144416280444;9079.04670009646;9101.31740119487;9101.772455688595;9103.0441803611;8875.378723489359;8998.280137588978;9190.908090919072;9228.031056739013;9239.815203695956;42385;42816.785916070534;43008.35487467691;43098.78450607727;43149.78425107854;3619.49327094207;3799.8290076946605;3839.2321535692695;3840.7695538267512;4243.342281946303;34002.31995360079;34177.14557136066;34319.6568034319;34525.13687157816;34646.307073858385;4144.585541445861;4215.32554791235;4236.724612900182;4286.635635970946;4313.41768861206;300082;301719;302222;302432;302480;67963;68728.31271687319;68743;68752;68766;73885.63057184679;74368.62815685887;75631;75659.62170189114;75773.62113189399;16687.249073791707;17030.74453883193;17086.48740537786;17090.914545427193;17114;12649.87350126487;12976.480940762263;12979.286139262242;12989.870101299055;12996.285204313665;21497.462563435725;21905.12379504802;21994;22004.33986980393;22012.229571964905;8277.8344433111;8571.485710857369;8591.48451092924;8618.78453038679;8837.116288371111;984.3306551545019;1000.5947591225565;1035.5443604814009;1071.3518321415588;1111.8499002634542;30074.69925300719;30419.543706844415;30431.847840760656;30458.338708237316;30562.861127714597;1100.867895852503;1142.149098921309;1158.0561842098662;1164.3770582738193;1168.3457263932225;15706.842931570538;15708.92145539265;15886.68226635484;16082;16187.028778273341;315475;317283;317957;319712;320141;56972.430275697545;57169.42830571724;57425;57496;57519;1314.750197462479;1437.4250299880132;1440.5462279381961;1471.9705605887823;1575.4643421236835;28036.85981570079;29232;29708.405831883672;30071.849640751658;30372;46482.767586161855;47393;47400.7629961848;47409.762951185025;47450.52549474461;226098.9560417565;228550;229496;229613;230020;30208.84895575596;34656.480152798234;34996.65003349934;35106.64893351034;35688.464673029404;42060;42086;42475.787621061696;42605.147897041265;42825.571744282155;35061.29877402489;35086.29827403386;35089;35331.11672208215;35350.116247094025;35651.28697425985;36899.07752306214;37436.25127497489;37519.24961500809;37581.81209094046;37983.81008094942;38127.23745525129;38335.233295334496;38923;39253.214935700555;33123.83438082794;33850.153746156546;34264.828675856465;34350.312993739484;34548.481772772924;26143.346416339744;26256.60615090737;26493.091241292863;26703.59944600794;26794.866025670526 13:29:57 INFO - PROCESS | 2112 | |2;jquery.html;379.89537959703244;381.6107570278316;384.5904112120591;389;391.2722336454193;17898.642027159465;17926.37257695981;18568.72146917794;18577.90711046446;18583.256669733193;16303.91848040761;17810.821891781077;18334.266629334812;18363.265469381244;18397.63204735908;5169.457206993258;5285.101532739424;5317.8936421271555;5319.281896943901;5321.255024296602;4011.7994100295014;5440.809571664992;5671.149327600872;5677.460641239076;5680.715964201794;5649.943500564983;5652.265205523297;5653.349864765543;5673.149027645865;5674.631148975324;5921.526277897758;5973.701314934257;6136.509079273647;6145.846353841145;6146.508279337642;5483.369412517532;5485.890282194334;5486.91769623456;5496.340439147288;5500.4224556421395;13764.17414955096;14136;14148.292585370793;14150.504732334319;14177.43290268388;2339.02930283932;2388.653645221433;2406.7352591214953;2408.879556022192;2495.7753802157895;10535.63125290611;11928.522859085626;13131.60605181846;13728.794068088986;14084.647883802987;1888.33908132154;1903.80010098939;1911.6081203353278;1921.8366438852715;1924.0956750327323;66890;68239;68347.31652683509;68556.97164542586;68635;10946.781064378667;11121.165912556591;11123.110151188048;11176.32942023465;11269.718257043476;14655.926720366544;14808.851911480962;14875.628109297355;14895.47865824691;14904;8222.301104406193;8329.292010179082;8333.125021872738;8377.37169712274;8453.492790432594;7764.534127952341;7773.144954055049;7865.764027079197;7889.132195458495;7961.681532738626;4671.369365135731;4752.52474752522;4806.7836947337455;4807.95192048082;4812.639052071108;1791.167107295114;1804.4906766350678;1874.4376686993846;1898.6012937283049;1905.1998160772232;482.7634459115008;484.2663365002025;1000.8124124662827;1033.6640591807693;1088.7768007558432;11684.649460516199;11944.880551194377;12122.212056216318;12152.817707734392;12231.816522752166;494.92823540587136;498.5637567128762;520.292402332827;524.446708722294;539.094321539809;6472.704147538673;6500.674966251669;6549.410553050248;6625.17185351831;6709.597424154566;434934;444139;447213;448968;451324;66372.33627663758;68075.65962170158;77447;78636.60681696555;78978.6051069741;1105.5909313553875;1113.04834366617;1142.1890457775073;1181.6809461445362;1185.4369174641977;15995.440159594824;16004.599885002503;16202.432914848396;16253.349866005228;16390.508284751475;32282.19294517562;32980.83509582437;33145.83427082849;34584.96245112651;34592;38613.613863861;46474;47215.29177062278;47473.28790068083;49075;8377.287930525974;8446.788830279293;8643.783905402415;8687.261582765283;8757.47455152693;12231.571894983634;12603.684907877376;12760.872391275969;13024.283664398548;13569.457221711022;10056.145227655732;10694.091002264895;10724.624638137628;10884.292520986111;11041;9787.608495660093;9912.553935073083;9930.702078937644;10315.48422578883;10638.095761860328;10627.574897004033;10755.784884302113;10806;10900.7274818127;11042.834357484484;8385.664573416994;8435.746927592181;8521.659133634585;8530.530820804915;8616.956915215384;9702.660406886007;10602.8939710605;10733.785324293627;10787;10958.890411095786 13:29:57 INFO - PROCESS | 2112 | |3;mootools.html;1544.4825983295596;1551.7517197248442;1574.6063484128968;1786.6694661487625;1902.6670332691783;7150.320719531643;7852.725154619582;8017.278444939954;8030.437869349148;8038.47749896257;7864.803379915505;8020.2380773826535;8025.438219324635;8029.35765138789;8039.839203215932;2101;2152.1068756466047;2366.988165059181;2416.2992732107714;2448.0574978633176;2438.1100898172126;2451.669024681663;2451.950960980779;2452.3378687754384;2456.2140115163156;2374.0622454130607;2400.2679182849224;2415;2416.9879150604224;2417.806575473967;2361.2916125162556;2406.9518609627885;2408.7350391456926;2422.915197968063;2424.62418325159;2394.928152155438;2419.600765873629;2427.781499665021;2428.271518544447;2430.6961629796274;8195.016598008218;8262.876056859091;8264.628091735825;8266.090730019692;8266.462679925786;5042.344495215599;5147.794088236466;5148.150555158394;5188.429272779991;5193.68837869729;3265.2163480764684;3284.8521816518314;3341.148007258158;3378.4932260160926;3437.8281085945605;985.65009421655;987.6888780034266;1019.3119644240182;1021.0912288063629;1032.7727899862093;11437;11439.370834604093;11445.25605835618;11460.541578336857;11461.484233209525;4594.908101837945;4668.836590719308;4727.479977202505;4756.143894099096;4773.1408346497965;9092.27261819053;9093.31800114994;9155.908440915638;9174.082591740906;9178.770530736785;5089.465606111379;5090.618203634742;5090.872728181751;5096.388433388017;5099.56653684441;4174.645155161785;4552.0668263006;4585.151746926763;4649.139909116757;4711.811527538928;3710.3135919854913;3797.5063241778394;3815.065308999313;3819.197968426606;3892.2215556888737;1105.8396532502902;1130.1806190511813;1130.3387518301886;1131.6209069961656;1133.8072527670151;1453.273363318341;1456.3009755317507;1459.912405255688;1479.0090639271714;1481.3111902965172;7867.095284042294;7921.405894557931;7964.362850971908;7969.641366138538;7980.281774640194;530.8327876718821;538.3270911360798;540.608059157108;542.1731858915107;543.8857839853596;5909.881802363929;5927.1405646181065;5955.196048533393;5986.072158815304;5987.191729116601;9644.132028117503;10244.948775256225;10255.58977640901;10291.073803357735;10292.125169360539;9733.805323893625;9919.355241909252;10064.69805905824;10070.244731645156;10143.898561014443;7617.238276172449;7728.806779830549;7764.767056988299;7795.532268063935;7812.257835505618;7548;7551;7576.393888489018;7611;7728.072631284282;8758.386912916034;8834.381593288665;8965.551722413722;9008.729738107868;9072.364934454788;9070.727878163665;9074.274058075207;9129.224015958718;9301.255899528156;9312.953435232781;6359.55483116196;6617.867642647217;6723.125993620798;7054.25930277334;7171.067761191011;7652.464327497022;7660.923390766244;7665.463417560717;7695.422843286664;7707.34487568563;6695.564788288746;6801.761938332134;6807.183138023469;6961.721531138698;7008.299170082951;6649.368310010541;6695.899561506679;6718.798436046926;6828.795136145924;6844.965775171092;7238.819029524093;7314.597697126496;7333;7352.080989876265;7361.30067643573;6733.192016957801;6744.763933262312;6772.255051944184;6781.457483401217;6786.151731033621;6687.097241872285;6753.088333074972;6762.985552167214;6778.830529236611;6787.151606049244 13:29:57 INFO - PROCESS | 2112 | |4;prototype.html;360.4521127885614;367.1537106968437;367.20683324020087;367.3882984830258;370.684917819853;6009.519238460924;6032.276126864777;6052.546059045578;6063.333033366326;6087.026075827868;5968.850778730534;5983.880322393549;5989.610675306102;5995.700214989244;6022.759089636409;4501.572350626693;4590.173768721629;4676.69601475903;4726.976365118169;4727.66906316558;4688.156131896258;4723.834665786698;4728.716277023373;4729.6452766042685;4729.9763501182615;4452.910941781162;4695.9530404696025;4700.200965835799;4700.200965835799;4711.29330600411;4533.3426653135275;4639.721616702992;4640.09518143962;4669.2062349400685;4694.859154225379;4149.107941792529;4153.7300075494995;4154.044569748975;4162.979185104085;4166.375043743433;5741.282339707536;5745.770169193227;5748.16651585522;5750.5687073469235;5753.1370294456165;5441.945580544223;5448.210009548593;5449.04641687703;5449.618526703132;5459.672419654833;6301.306856245809;6303.810885673392;6309.305976342599;6311.747530098791;6312;4514.097180563867;4635.791389387486;4642.396488456513;4644.326572646947;4650.86047418578;6545.345465453464;6627.337266273383;6650.268470468244;6651.035599838045;6654.567453115532;4763.857084287408;4776.188048031843;4777.665563410528;4781.402324709411;4788.928166077511;4849.175640141114;4850.6362022847725;4853.878653033632;4855.490173531799;4855.708657480563;5473.17902314656;5482.314710661168;5482.588805839578;5489.780408783604;5490.203920431515;6254.906176407358;6400.943844265737;6408.295087540367;6416.390442908009;6431.324710905381;1693.9237734301987;1700.0819557439092;1711.9743203851951;1712.289399899028;1712.6831536165848;1079.6868908016745;1154.1401655766508;1154.9884501154881;1184.5972369394447;1188.0970462448429;6038.969805151034;6087.817365479043;6095.481884039907;6098.573099882966;6111.236095488064;6517.837054073591;6557.409833115043;6580.11168492257;6583.934160658428;6588.439982601532;6043.8186854394435;6045;6084.604500707528;6090.086487026982;6091.695415229221;3521.0669172669263;3557.092941299952;3557.1640664443835;3557.288542291552;3559.501669766235;6628.767993120314;6781.593104413751;6783.62690052042;6790.219124800612;6791.796246112525;6675.365840245169;6682.732690692415;6701.061851340816;6706.631135287606;6720.966395167993;6762.087118239073;6762.628055456898;6772.2211945625895;6774.83062923421;6775.93224067753;6554.606723596599;6554.63949482783;6557.606543607399;6559.442447391834;6559.770408035696;6329.309888485513;6438.90341644885;6446.903296450463;6466.4503517201565;6467.482601391972;6746.763863264762;6766.391024807791;6783.321667833177;6786.898196526958;6798.592084474947;4685.273782563708;4687.39063921688;4690.507496712796;4691.976540117277;4693.483716791218;6540.672966351759;6542;6548.967255163694;6552.803415897531;6554.705038273194;6231.1276421300145;6366.840828979312;6368.77709280173;6374.840628984312;6379.936200637934;6436.356364363526;6473.611583305017;6493.805185844432;6498.675066246763;6552.606843589209;6410.166678331787;6411.903821442589;6415.390537898892;6417.197850268716;6421.133147025092;6515.218173819172;6517.967410162919;6528.4984453575;6528.771492997722;6539.444147247537;6083.878322433615;6207.844803879759;6225.626462412089;6356.77751278703;6387.105805187371 13:29:57 INFO - PROCESS | 2112 | |5;yui.html;836.2300129109146;842.9704960326386;861.9655213791448;869.0961400143851;879.1735768377724;14715;14762.852371476281;14785.408583656641;14790.482333118343;14813.925930370333;13720.176789392643;13775.173489590607;13822;14551.345189466472;15515.379384824622;922.6908985489869;931.7065124485765;933.0529512544772;937.634322614181;938.713692323841;915.9771005724843;918.7381596245071;919.7010971434278;922.1331947968888;922.1331947968921;979.6620166042704;985.4235272365675;985.9844360308894;986.5018165826248;986.6891929042365;972.6449845806301;973.790635013472;975.8243516167087;975.8585005174245;975.8877729061178;720.5820624038046;722.6386806596702;723.3309189000206;723.5188599581272;724.1201939643306;14212.360443780055;14427.639309017359;14427.927860360736;14490.56528304142;14496.275186240646;13760.17438953666;13878.167309961334;14032.508862189774;14062.085964412281;14115.294235288195;11540.711482212928;11610.825837612443;11638.243514171552;11694.12294077939;11704.414779261004;3954.3079961006997;3979.602039796026;4003.499562554681;4011.919761604781;4064.3903414488063;48643.27035094477;48791.26813097807;48939;55309;55749;10877.564897404174;11213.66359009231;11280.323180609026;11466.54133834654;11580.305181688957;19976.90011549933;19983.800161998195;20026.499337516678;20045.899770501055;20068.096935637932;8578.656853725906;8595.527246001406;8647.610857511301;8730.607122679494;8811.911880881238;4635.629149668019;4679.134360143385;4742.502037286035;4761.785719642625;4774.427068751703;3437.9828100859336;3481.1819222482695;3483.4774783782636;3491.94762078569;3495.265994141208;597.8176656119925;608.057510858168;614.9323574406811;616.0297531388081;632.077167335695;735.9843416085768;751.7293774241268;769.4767558060572;775.097011981047;788.247223901173;8888.155625215593;9184.540772961325;9338.486383248986;9690.12788848993;9693.9030609693;644.1014784375769;758.2531206761336;768.8577613141475;773.5977291808229;795.8090058385945;3978.661813745864;4070;4146.129312844276;4248.85129020489;4295.892602684958;57727;57876;58105.128423073686;58430;58456.4154358451;52245.2163217552;53459.46540534545;53667.46332536625;54223.186652200246;54286;43369.50708062366;44019.33970990438;46040.53959460362;49667.25499117516;51121.74439127855;8563.700270490503;8755.781105472413;8787.428817126865;8838.469691818511;8973.05782892813;35245.47131792974;36172.81913590521;36372.27255454929;36748.63251367452;36850.8157459211;44432.33351499795;45478;46855;46869.765651171525;47037.059258815316;10848.566057357617;11065.114790816555;11305.660830175108;11352.262102963281;11612.303261804318;12558.120931534704;13113.213207207598;13227.206367617973;13231.073824832169;13733.862661373258;11908.345041022827;11970.700732481757;12124.818127727915;12765.93617031909;12975.675608109872;11366;11378.374189419661;11526.827097593376;11700.35648039366;12371;11384.203105782515;12010.159288850045;12093.69765755828;12368.567100151451;12546.1844980076;10427.739306517398;10455.059044686015;10607.204459665401;10655.20085993569;10985.121190304917;10316.742081447723;10461;10470.11004064663;10535.525901334306;10571.841422378517 13:29:57 INFO - PROCESS | 2112 | __end_tp_report 13:29:57 INFO - PROCESS | 2112 | __start_cc_report 13:29:57 INFO - PROCESS | 2112 | _x_x_mozilla_cycle_collect,1180 13:29:57 INFO - PROCESS | 2112 | __end_cc_report 13:29:57 INFO - PROCESS | 2112 | __startTimestamp1457987397687__endTimestamp 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | ------- Summary: start ------- 13:29:57 INFO - PROCESS | 2112 | Number of tests: 6 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | [#0] dojo.html Cycles:165 Average:5376.12 Median:5629.52 stddev:592.22 (10.5%) stddev-sans-first:570.30 13:29:57 INFO - PROCESS | 2112 | Values: 3260.0 3276.8 3291.2 3303.5 3319.4 5256.1 5269.1 5280.6 5281.0 5346.2 5264.3 5288.4 5296.7 5310.0 5332.8 4812.1 4833.4 4836.7 4885.7 4933.5 4904.6 5004.2 5008.1 5013.8 5015.3 4959.9 5023.9 5031.7 5043.2 5049.7 4923.6 4930.5 5066.3 5067.9 5074.3 4815.1 4835.2 4862.1 4903.9 4930.3 5116.6 5180.2 5214.8 5230.1 5234.9 5678.1 5698.8 5701.5 5706.0 5743.7 5687.7 5740.8 5745.6 5748.5 5767.6 5444.2 5460.0 5481.7 5484.1 5511.1 5967.0 5994.4 5997.3 5998.5 6001.2 5654.6 5702.7 5732.1 5751.7 5757.8 5851.5 5855.0 5857.0 5862.4 5865.5 5807.6 5818.8 5820.4 5820.9 5823.5 5677.5 5760.1 5805.0 5820.2 5828.4 4417.8 4420.0 4421.5 4427.5 4444.4 4006.3 4008.6 4023.7 4029.2 4049.4 5205.5 5391.5 5435.2 5474.8 5478.6 5771.4 5809.7 5819.1 5838.2 5842.8 5156.7 5387.3 5427.3 5435.0 5436.3 4934.1 4967.9 4975.8 4988.0 5004.9 6022.7 6058.8 6070.2 6093.7 6097.6 5711.7 5845.5 5897.4 5905.1 5913.5 5904.9 5914.4 5915.2 5915.7 5926.0 5605.1 5629.5 5644.2 5647.5 5667.6 5719.7 5751.7 5772.9 5812.2 5817.4 5743.8 5750.1 5757.1 5757.9 5763.0 5727.1 5755.3 5755.8 5762.5 5762.9 5554.6 5659.5 5672.0 5714.4 5742.9 5641.8 5642.2 5692.4 5710.9 5716.7 5302.9 5385.6 5386.8 5428.9 5435.0 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | [#1] ext.html Cycles:180 Average:46852.48 Median:20259.29 stddev:74636.33 (368.4%) stddev-sans-first:74764.64 13:29:57 INFO - PROCESS | 2112 | Values: 523.2 561.7 571.6 574.7 619.4 30737.0 31404.4 31426.4 31426.7 31435.7 39272.8 39580.8 39633.4 39635.4 39701.4 8966.1 9123.3 9146.0 9146.9 9152.8 8933.9 9078.5 9081.5 9086.3 9088.5 9063.8 9175.6 9179.9 9180.6 9180.7 9006.1 9079.0 9101.3 9101.8 9103.0 8875.4 8998.3 9190.9 9228.0 9239.8 42385.0 42816.8 43008.4 43098.8 43149.8 3619.5 3799.8 3839.2 3840.8 4243.3 34002.3 34177.1 34319.7 34525.1 34646.3 4144.6 4215.3 4236.7 4286.6 4313.4 300082.0 301719.0 302222.0 302432.0 302480.0 67963.0 68728.3 68743.0 68752.0 68766.0 73885.6 74368.6 75631.0 75659.6 75773.6 16687.2 17030.7 17086.5 17090.9 17114.0 12649.9 12976.5 12979.3 12989.9 12996.3 21497.5 21905.1 21994.0 22004.3 22012.2 8277.8 8571.5 8591.5 8618.8 8837.1 984.3 1000.6 1035.5 1071.4 1111.8 30074.7 30419.5 30431.8 30458.3 30562.9 1100.9 1142.1 1158.1 1164.4 1168.3 15706.8 15708.9 15886.7 16082.0 16187.0 315475.0 317283.0 317957.0 319712.0 320141.0 56972.4 57169.4 57425.0 57496.0 57519.0 1314.8 1437.4 1440.5 1472.0 1575.5 28036.9 29232.0 29708.4 30071.8 30372.0 46482.8 47393.0 47400.8 47409.8 47450.5 226099.0 228550.0 229496.0 229613.0 230020.0 30208.8 34656.5 34996.7 35106.6 35688.5 42060.0 42086.0 42475.8 42605.1 42825.6 35061.3 35086.3 35089.0 35331.1 35350.1 35651.3 36899.1 37436.3 37519.2 37581.8 37983.8 38127.2 38335.2 38923.0 39253.2 33123.8 33850.2 34264.8 34350.3 34548.5 26143.3 26256.6 26493.1 26703.6 26794.9 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | [#2] jquery.html Cycles:180 Average:25560.21 Median:383.10 stddev:73056.78 (19069.9%) stddev-sans-first:73237.26 13:29:57 INFO - PROCESS | 2112 | Values: 379.9 381.6 384.6 389.0 391.3 17898.6 17926.4 18568.7 18577.9 18583.3 16303.9 17810.8 18334.3 18363.3 18397.6 5169.5 5285.1 5317.9 5319.3 5321.3 4011.8 5440.8 5671.1 5677.5 5680.7 5649.9 5652.3 5653.3 5673.1 5674.6 5921.5 5973.7 6136.5 6145.8 6146.5 5483.4 5485.9 5486.9 5496.3 5500.4 13764.2 14136.0 14148.3 14150.5 14177.4 2339.0 2388.7 2406.7 2408.9 2495.8 10535.6 11928.5 13131.6 13728.8 14084.6 1888.3 1903.8 1911.6 1921.8 1924.1 66890.0 68239.0 68347.3 68557.0 68635.0 10946.8 11121.2 11123.1 11176.3 11269.7 14655.9 14808.9 14875.6 14895.5 14904.0 8222.3 8329.3 8333.1 8377.4 8453.5 7764.5 7773.1 7865.8 7889.1 7961.7 4671.4 4752.5 4806.8 4808.0 4812.6 1791.2 1804.5 1874.4 1898.6 1905.2 482.8 484.3 1000.8 1033.7 1088.8 11684.6 11944.9 12122.2 12152.8 12231.8 494.9 498.6 520.3 524.4 539.1 6472.7 6500.7 6549.4 6625.2 6709.6 434934.0 444139.0 447213.0 448968.0 451324.0 66372.3 68075.7 77447.0 78636.6 78978.6 1105.6 1113.0 1142.2 1181.7 1185.4 15995.4 16004.6 16202.4 16253.3 16390.5 32282.2 32980.8 33145.8 34585.0 34592.0 38613.6 46474.0 47215.3 47473.3 49075.0 8377.3 8446.8 8643.8 8687.3 8757.5 12231.6 12603.7 12760.9 13024.3 13569.5 10056.1 10694.1 10724.6 10884.3 11041.0 9787.6 9912.6 9930.7 10315.5 10638.1 10627.6 10755.8 10806.0 10900.7 11042.8 8385.7 8435.7 8521.7 8530.5 8617.0 9702.7 10602.9 10733.8 10787.0 10958.9 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | [#3] mootools.html Cycles:180 Average:5706.83 Median:5918.51 stddev:2980.35 (50.4%) stddev-sans-first:2972.29 13:29:57 INFO - PROCESS | 2112 | Values: 1544.5 1551.8 1574.6 1786.7 1902.7 7150.3 7852.7 8017.3 8030.4 8038.5 7864.8 8020.2 8025.4 8029.4 8039.8 2101.0 2152.1 2367.0 2416.3 2448.1 2438.1 2451.7 2452.0 2452.3 2456.2 2374.1 2400.3 2415.0 2417.0 2417.8 2361.3 2407.0 2408.7 2422.9 2424.6 2394.9 2419.6 2427.8 2428.3 2430.7 8195.0 8262.9 8264.6 8266.1 8266.5 5042.3 5147.8 5148.2 5188.4 5193.7 3265.2 3284.9 3341.1 3378.5 3437.8 985.7 987.7 1019.3 1021.1 1032.8 11437.0 11439.4 11445.3 11460.5 11461.5 4594.9 4668.8 4727.5 4756.1 4773.1 9092.3 9093.3 9155.9 9174.1 9178.8 5089.5 5090.6 5090.9 5096.4 5099.6 4174.6 4552.1 4585.2 4649.1 4711.8 3710.3 3797.5 3815.1 3819.2 3892.2 1105.8 1130.2 1130.3 1131.6 1133.8 1453.3 1456.3 1459.9 1479.0 1481.3 7867.1 7921.4 7964.4 7969.6 7980.3 530.8 538.3 540.6 542.2 543.9 5909.9 5927.1 5955.2 5986.1 5987.2 9644.1 10244.9 10255.6 10291.1 10292.1 9733.8 9919.4 10064.7 10070.2 10143.9 7617.2 7728.8 7764.8 7795.5 7812.3 7548.0 7551.0 7576.4 7611.0 7728.1 8758.4 8834.4 8965.6 9008.7 9072.4 9070.7 9074.3 9129.2 9301.3 9313.0 6359.6 6617.9 6723.1 7054.3 7171.1 7652.5 7660.9 7665.5 7695.4 7707.3 6695.6 6801.8 6807.2 6961.7 7008.3 6649.4 6695.9 6718.8 6828.8 6845.0 7238.8 7314.6 7333.0 7352.1 7361.3 6733.2 6744.8 6772.3 6781.5 6786.2 6687.1 6753.1 6763.0 6778.8 6787.2 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | [#4] prototype.html Cycles:180 Average:5384.60 Median:6057.94 stddev:1573.21 (26.0%) stddev-sans-first:1531.76 13:29:57 INFO - PROCESS | 2112 | Values: 360.5 367.2 367.2 367.4 370.7 6009.5 6032.3 6052.5 6063.3 6087.0 5968.9 5983.9 5989.6 5995.7 6022.8 4501.6 4590.2 4676.7 4727.0 4727.7 4688.2 4723.8 4728.7 4729.6 4730.0 4452.9 4696.0 4700.2 4700.2 4711.3 4533.3 4639.7 4640.1 4669.2 4694.9 4149.1 4153.7 4154.0 4163.0 4166.4 5741.3 5745.8 5748.2 5750.6 5753.1 5441.9 5448.2 5449.0 5449.6 5459.7 6301.3 6303.8 6309.3 6311.7 6312.0 4514.1 4635.8 4642.4 4644.3 4650.9 6545.3 6627.3 6650.3 6651.0 6654.6 4763.9 4776.2 4777.7 4781.4 4788.9 4849.2 4850.6 4853.9 4855.5 4855.7 5473.2 5482.3 5482.6 5489.8 5490.2 6254.9 6400.9 6408.3 6416.4 6431.3 1693.9 1700.1 1712.0 1712.3 1712.7 1079.7 1154.1 1155.0 1184.6 1188.1 6039.0 6087.8 6095.5 6098.6 6111.2 6517.8 6557.4 6580.1 6583.9 6588.4 6043.8 6045.0 6084.6 6090.1 6091.7 3521.1 3557.1 3557.2 3557.3 3559.5 6628.8 6781.6 6783.6 6790.2 6791.8 6675.4 6682.7 6701.1 6706.6 6721.0 6762.1 6762.6 6772.2 6774.8 6775.9 6554.6 6554.6 6557.6 6559.4 6559.8 6329.3 6438.9 6446.9 6466.5 6467.5 6746.8 6766.4 6783.3 6786.9 6798.6 4685.3 4687.4 4690.5 4692.0 4693.5 6540.7 6542.0 6549.0 6552.8 6554.7 6231.1 6366.8 6368.8 6374.8 6379.9 6436.4 6473.6 6493.8 6498.7 6552.6 6410.2 6411.9 6415.4 6417.2 6421.1 6515.2 6518.0 6528.5 6528.8 6539.4 6083.9 6207.8 6225.6 6356.8 6387.1 13:29:57 INFO - PROCESS | 2112 | 13:29:57 INFO - PROCESS | 2112 | [#5] yui.html Cycles:180 Average:14586.02 Median:43694.42 stddev:16428.23 (37.6%) stddev-sans-first:16441.87 13:29:57 INFO - PROCESS | 2112 | Values: 836.2 843.0 862.0 869.1 879.2 14715.0 14762.9 14785.4 14790.5 14813.9 13720.2 13775.2 13822.0 14551.3 15515.4 922.7 931.7 933.1 937.6 938.7 916.0 918.7 919.7 922.1 922.1 979.7 985.4 986.0 986.5 986.7 972.6 973.8 975.8 975.9 975.9 720.6 722.6 723.3 723.5 724.1 14212.4 14427.6 14427.9 14490.6 14496.3 13760.2 13878.2 14032.5 14062.1 14115.3 11540.7 11610.8 11638.2 11694.1 11704.4 3954.3 3979.6 4003.5 4011.9 4064.4 48643.3 48791.3 48939.0 55309.0 55749.0 10877.6 11213.7 11280.3 11466.5 11580.3 19976.9 19983.8 20026.5 20045.9 20068.1 8578.7 8595.5 8647.6 8730.6 8811.9 4635.6 4679.1 4742.5 4761.8 4774.4 3438.0 3481.2 3483.5 3491.9 3495.3 597.8 608.1 614.9 616.0 632.1 736.0 751.7 769.5 775.1 788.2 8888.2 9184.5 9338.5 9690.1 9693.9 644.1 758.3 768.9 773.6 795.8 3978.7 4070.0 4146.1 4248.9 4295.9 57727.0 57876.0 58105.1 58430.0 58456.4 52245.2 53459.5 53667.5 54223.2 54286.0 43369.5 44019.3 46040.5 49667.3 51121.7 8563.7 8755.8 8787.4 8838.5 8973.1 35245.5 36172.8 36372.3 36748.6 36850.8 44432.3 45478.0 46855.0 46869.8 47037.1 10848.6 11065.1 11305.7 11352.3 11612.3 12558.1 13113.2 13227.2 13231.1 13733.9 11908.3 11970.7 12124.8 12765.9 12975.7 11366.0 11378.4 11526.8 11700.4 12371.0 11384.2 12010.2 12093.7 12368.6 12546.2 10427.7 10455.1 10607.2 10655.2 10985.1 10316.7 10461.0 10470.1 10535.5 10571.8 13:29:57 INFO - PROCESS | 2112 | -------- Summary: end -------- 13:29:57 INFO - PROCESS | 2112 | 13:29:58 INFO - TEST-INFO | 2112: exit 0 13:29:58 INFO - TEST-OK | dromaeo_css | took 1111998ms 13:29:58 INFO - TEST-START | kraken 13:29:58 INFO - operating with platform_type : linux_ 13:29:58 INFO - Initialising browser for kraken test... 13:29:58 INFO - TEST-INFO | started process 2306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9tMmtm/profile http://localhost:60603/getInfo.html) 13:30:02 INFO - PROCESS | 2306 | __metrics Screen width/height:1600/1200 13:30:02 INFO - PROCESS | 2306 | colorDepth:24 13:30:02 INFO - PROCESS | 2306 | Browser inner width/height: 1024/697 13:30:02 INFO - PROCESS | 2306 | __metrics 13:30:03 INFO - PROCESS | 2306 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:04 INFO - TEST-INFO | 2306: exit 0 13:30:04 INFO - Browser initialized. 13:30:04 INFO - Running cycle 1/1 for kraken test... 13:30:04 INFO - TEST-INFO | started process 2488 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9tMmtm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:16 INFO - PROCESS | 2488 | RSS: Main: 144957440 13:30:16 INFO - PROCESS | 2488 | 13:30:18 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60603/tests/kraken/driver.html?testName=audio-beat-detection) 13:30:19 INFO - PROCESS | 2488 | RSS: Main: 180391936 13:30:19 INFO - PROCESS | 2488 | 13:30:21 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60603/tests/kraken/driver.html?testName=audio-dft) 13:30:22 INFO - PROCESS | 2488 | RSS: Main: 178958336 13:30:22 INFO - PROCESS | 2488 | 13:30:25 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60603/tests/kraken/driver.html?testName=audio-fft) 13:30:25 INFO - PROCESS | 2488 | RSS: Main: 175620096 13:30:25 INFO - PROCESS | 2488 | 13:30:27 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60603/tests/kraken/driver.html?testName=audio-oscillator) 13:30:28 INFO - PROCESS | 2488 | RSS: Main: 175497216 13:30:28 INFO - PROCESS | 2488 | 13:30:30 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:30:31 INFO - PROCESS | 2488 | RSS: Main: 172376064 13:30:31 INFO - PROCESS | 2488 | 13:30:34 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60603/tests/kraken/driver.html?testName=imaging-darkroom) 13:30:34 INFO - PROCESS | 2488 | RSS: Main: 172834816 13:30:34 INFO - PROCESS | 2488 | 13:30:38 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60603/tests/kraken/driver.html?testName=imaging-desaturate) 13:30:38 INFO - PROCESS | 2488 | RSS: Main: 174329856 13:30:38 INFO - PROCESS | 2488 | 13:30:41 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60603/tests/kraken/driver.html?testName=json-parse-financial) 13:30:42 INFO - PROCESS | 2488 | RSS: Main: 174669824 13:30:42 INFO - PROCESS | 2488 | 13:30:43 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:30:44 INFO - PROCESS | 2488 | RSS: Main: 179179520 13:30:44 INFO - PROCESS | 2488 | 13:30:45 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:30:46 INFO - PROCESS | 2488 | RSS: Main: 174710784 13:30:46 INFO - PROCESS | 2488 | 13:30:48 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:30:49 INFO - PROCESS | 2488 | RSS: Main: 183676928 13:30:49 INFO - PROCESS | 2488 | 13:30:51 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:30:52 INFO - PROCESS | 2488 | RSS: Main: 188518400 13:30:52 INFO - PROCESS | 2488 | 13:30:54 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:30:55 INFO - PROCESS | 2488 | RSS: Main: 189288448 13:30:55 INFO - PROCESS | 2488 | 13:30:56 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:60603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60603/tests/kraken/driver.html?testName=ai-astar) 13:30:57 INFO - PROCESS | 2488 | RSS: Main: 249761792 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | __start_tp_report 13:30:57 INFO - PROCESS | 2488 | _x_x_mozilla_page_load 13:30:57 INFO - PROCESS | 2488 | _x_x_mozilla_page_load_details 13:30:57 INFO - PROCESS | 2488 | |i|pagename|runs| 13:30:57 INFO - PROCESS | 2488 | |0;ai-astar;111;112;105;111;112;112;98;109;109;109 13:30:57 INFO - PROCESS | 2488 | |1;audio-beat-detection;149;124;149;169;125;147;149;125;178;125 13:30:57 INFO - PROCESS | 2488 | |2;audio-dft;159;161;160;159;160;160;159;164;161;161 13:30:57 INFO - PROCESS | 2488 | |3;audio-fft;75;76;78;159;75;76;76;77;159;76 13:30:57 INFO - PROCESS | 2488 | |4;audio-oscillator;92;93;145;92;92;92;135;93;93;141 13:30:57 INFO - PROCESS | 2488 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;116;116;117 13:30:57 INFO - PROCESS | 2488 | |6;imaging-darkroom;146;146;145;146;146;145;146;145;146;145 13:30:57 INFO - PROCESS | 2488 | |7;imaging-desaturate;95;95;95;95;96;95;96;95;95;95 13:30:57 INFO - PROCESS | 2488 | |8;json-parse-financial;54;56;55;54;57;55;56;62;55;53 13:30:57 INFO - PROCESS | 2488 | |9;json-stringify-tinderbox;65;64;64;64;65;64;64;65;65;64 13:30:57 INFO - PROCESS | 2488 | |10;stanford-crypto-aes;77;78;79;79;79;79;79;80;76;80 13:30:57 INFO - PROCESS | 2488 | |11;stanford-crypto-ccm;112;111;109;127;110;113;107;110;112;121 13:30:57 INFO - PROCESS | 2488 | |12;stanford-crypto-pbkdf2;148;134;144;153;144;136;149;145;141;143 13:30:57 INFO - PROCESS | 2488 | |13;stanford-crypto-sha256-iterative;65;68;66;66;66;64;66;66;63;65 13:30:57 INFO - PROCESS | 2488 | __end_tp_report 13:30:57 INFO - PROCESS | 2488 | __start_cc_report 13:30:57 INFO - PROCESS | 2488 | _x_x_mozilla_cycle_collect,1055 13:30:57 INFO - PROCESS | 2488 | __end_cc_report 13:30:57 INFO - PROCESS | 2488 | __startTimestamp1457987457062__endTimestamp 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | ------- Summary: start ------- 13:30:57 INFO - PROCESS | 2488 | Number of tests: 14 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.50 stddev:4.37 (3.9%) stddev-sans-first:4.56 13:30:57 INFO - PROCESS | 2488 | Values: 111.0 112.0 105.0 111.0 112.0 112.0 98.0 109.0 109.0 109.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:149.00 stddev:19.29 (12.9%) stddev-sans-first:20.37 13:30:57 INFO - PROCESS | 2488 | Values: 149.0 124.0 149.0 169.0 125.0 147.0 149.0 125.0 178.0 125.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.51 (0.9%) stddev-sans-first:1.51 13:30:57 INFO - PROCESS | 2488 | Values: 159.0 161.0 160.0 159.0 160.0 160.0 159.0 164.0 161.0 161.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:34.95 (46.0%) stddev-sans-first:36.48 13:30:57 INFO - PROCESS | 2488 | Values: 75.0 76.0 78.0 159.0 75.0 76.0 76.0 77.0 159.0 76.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:92.00 stddev:23.27 (25.3%) stddev-sans-first:24.05 13:30:57 INFO - PROCESS | 2488 | Values: 92.0 93.0 145.0 92.0 92.0 92.0 135.0 93.0 93.0 141.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:30:57 INFO - PROCESS | 2488 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 116.0 117.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:30:57 INFO - PROCESS | 2488 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:30:57 INFO - PROCESS | 2488 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:2.50 (4.5%) stddev-sans-first:2.57 13:30:57 INFO - PROCESS | 2488 | Values: 54.0 56.0 55.0 54.0 57.0 55.0 56.0 62.0 55.0 53.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 13:30:57 INFO - PROCESS | 2488 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:1.26 (1.6%) stddev-sans-first:1.20 13:30:57 INFO - PROCESS | 2488 | Values: 77.0 78.0 79.0 79.0 79.0 79.0 79.0 80.0 76.0 80.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:112.00 stddev:6.11 (5.5%) stddev-sans-first:6.46 13:30:57 INFO - PROCESS | 2488 | Values: 112.0 111.0 109.0 127.0 110.0 113.0 107.0 110.0 112.0 121.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:144.50 stddev:5.74 (4.0%) stddev-sans-first:5.87 13:30:57 INFO - PROCESS | 2488 | Values: 148.0 134.0 144.0 153.0 144.0 136.0 149.0 145.0 141.0 143.0 13:30:57 INFO - PROCESS | 2488 | 13:30:57 INFO - PROCESS | 2488 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 13:30:57 INFO - PROCESS | 2488 | Values: 65.0 68.0 66.0 66.0 66.0 64.0 66.0 66.0 63.0 65.0 13:30:57 INFO - PROCESS | 2488 | -------- Summary: end -------- 13:30:57 INFO - PROCESS | 2488 | 13:30:58 INFO - TEST-INFO | 2488: exit 0 13:30:58 INFO - TEST-OK | kraken | took 59628ms 13:30:58 INFO - SUITE-END | took 1171s 13:30:58 INFO - Completed test suite (00:19:31) 13:30:58 INFO - javascript benchmark 13:30:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3259.983700081499, 3276.8361581920926, 3291.1607540077293, 3303.5209894565287, 3319.41910165721, 5256.132738098214, 5269.051570717269, 5280.630355875091, 5280.973595132019, 5346.198070289453, 5264.341957255343, 5288.444713305095, 5296.682199068058, 5309.973450132754, 5332.760025798839, 4812.0857037163005, 4833.371661683985, 4836.733979631119, 4885.658003939726, 4933.531314525115, 4904.632152588552, 5004.249362595621, 5008.123578373788, 5013.799448022075, 5015.272785446108, 4959.876003099934, 5023.899522009558, 5031.748412579374, 5043.218301163325, 5049.722265275408, 4923.581495572845, 4930.457649658535, 5066.341375621146, 5067.923981140304, 5074.314967479399, 4815.085133824562, 4835.226363781813, 4862.051899879525, 4903.901921961577, 4930.309756634074, 5116.641835071547, 5180.197069454203, 5214.765335559909, 5230.137027390476, 5234.92147617786, 5678.119891416837, 5698.8290351289525, 5701.515371193454, 5705.971470142623, 5743.712814359265, 5687.744051517691, 5740.827775166752, 5745.626534275259, 5748.48263656273, 5767.567432442584, 5444.156155795858, 5460.017196904595, 5481.698506582136, 5484.095124304485, 5511.118221084607, 5966.970165149147, 5994.430529099728, 5997.340292567814, 5998.490128339053, 6001.159837622737, 5654.575906807006, 5702.6863522506665, 5732.054211055212, 5751.741171647286, 5757.769689212469, 5851.502622277069, 5855.03391940325, 5857.0, 5862.443067908627, 5865.530757539386, 5807.5644326675665, 5818.825435236865, 5820.417958204231, 5820.854478638068, 5823.505002074871, 5677.460641239076, 5760.107183386582, 5805.01314776489, 5820.214271073351, 5828.388019258002, 4417.779111044435, 4419.955800442019, 4421.53573874745, 4427.535108813592, 4444.377787109807, 4006.2788698034633, 4008.599140086026, 4023.6781057515327, 4029.194161167778, 4049.4128351388886, 5205.531502164823, 5391.460853914656, 5435.157550579666, 5474.808381706701, 5478.643888147258, 5771.394003629643, 5809.709514524341, 5819.068948968229, 5838.241028666246, 5842.824715258549, 5156.716380599028, 5387.272718182995, 5427.3215848019, 5434.972825135849, 5436.266104075899, 4934.062528119717, 4967.925481117786, 4975.825846095369, 4987.950120498821, 5004.899902001939, 6022.728977196037, 6058.848528786815, 6070.150178974947, 6093.66484843329, 6097.603655762361, 5711.7429715662065, 5845.532357411482, 5897.3807750187325, 5905.084711869667, 5913.46778789911, 5904.940950590611, 5914.378990206139, 5915.201447804491, 5915.70421478933, 5926.0, 5605.131204663284, 5629.521490673339, 5644.181593668977, 5647.548196144381, 5667.574931880208, 5719.7426115824055, 5751.683657398883, 5772.913406298825, 5812.21535092757, 5817.418258174149, 5743.770249189985, 5750.13747937796, 5757.0788673811985, 5757.91363129545, 5763.0, 5727.083666613322, 5755.3381361144, 5755.827325180251, 5762.5389968801555, 5762.942370576408, 5554.638948468337, 5659.518940890071, 5672.03575392176, 5714.3714191438075, 5742.942570574241, 5641.830745077655, 5642.238297829905, 5692.373838877637, 5710.942890571041, 5716.714164291686, 5302.893942121059, 5385.569154467712, 5386.757595908115, 5428.945710543002, 5435.048866448435], "unit": "score", "name": "dojo.html", "value": 5338.3962255834385}, {"lowerIsBetter": false, "replicates": [523.2497612333485, 561.7387914619703, 571.5598988778638, 574.695411431941, 619.3806193806194, 30737.0, 31404.371912561735, 31426.371472570536, 31426.68573314266, 31435.685643143563, 39272.80363598185, 39580.80209598948, 39633.40549891754, 39635.40546891792, 39701.40447893284, 8966.103389661046, 9123.315751318678, 9145.954270228673, 9146.908530914705, 9152.816943661122, 8933.910660893405, 9078.455292682427, 9081.545922703872, 9086.318526110535, 9088.50013249271, 9063.773405664846, 9175.632974681004, 9179.908200917973, 9180.632774689004, 9180.6786762463, 9006.144416280444, 9079.04670009646, 9101.31740119487, 9101.772455688595, 9103.0441803611, 8875.378723489359, 8998.280137588978, 9190.908090919072, 9228.031056739013, 9239.815203695956, 42385.0, 42816.785916070534, 43008.35487467691, 43098.78450607727, 43149.78425107854, 3619.49327094207, 3799.8290076946605, 3839.2321535692695, 3840.7695538267512, 4243.342281946303, 34002.31995360079, 34177.14557136066, 34319.6568034319, 34525.13687157816, 34646.307073858385, 4144.585541445861, 4215.32554791235, 4236.724612900182, 4286.635635970946, 4313.41768861206, 300082.0, 301719.0, 302222.0, 302432.0, 302480.0, 67963.0, 68728.31271687319, 68743.0, 68752.0, 68766.0, 73885.63057184679, 74368.62815685887, 75631.0, 75659.62170189114, 75773.62113189399, 16687.249073791707, 17030.74453883193, 17086.48740537786, 17090.914545427193, 17114.0, 12649.87350126487, 12976.480940762263, 12979.286139262242, 12989.870101299055, 12996.285204313665, 21497.462563435725, 21905.12379504802, 21994.0, 22004.33986980393, 22012.229571964905, 8277.8344433111, 8571.485710857369, 8591.48451092924, 8618.78453038679, 8837.116288371111, 984.3306551545019, 1000.5947591225565, 1035.5443604814009, 1071.3518321415588, 1111.8499002634542, 30074.69925300719, 30419.543706844415, 30431.847840760656, 30458.338708237316, 30562.861127714597, 1100.867895852503, 1142.149098921309, 1158.0561842098662, 1164.3770582738193, 1168.3457263932225, 15706.842931570538, 15708.92145539265, 15886.68226635484, 16082.0, 16187.028778273341, 315475.0, 317283.0, 317957.0, 319712.0, 320141.0, 56972.430275697545, 57169.42830571724, 57425.0, 57496.0, 57519.0, 1314.750197462479, 1437.4250299880132, 1440.5462279381961, 1471.9705605887823, 1575.4643421236835, 28036.85981570079, 29232.0, 29708.405831883672, 30071.849640751658, 30372.0, 46482.767586161855, 47393.0, 47400.7629961848, 47409.762951185025, 47450.52549474461, 226098.9560417565, 228550.0, 229496.0, 229613.0, 230020.0, 30208.84895575596, 34656.480152798234, 34996.65003349934, 35106.64893351034, 35688.464673029404, 42060.0, 42086.0, 42475.787621061696, 42605.147897041265, 42825.571744282155, 35061.29877402489, 35086.29827403386, 35089.0, 35331.11672208215, 35350.116247094025, 35651.28697425985, 36899.07752306214, 37436.25127497489, 37519.24961500809, 37581.81209094046, 37983.81008094942, 38127.23745525129, 38335.233295334496, 38923.0, 39253.214935700555, 33123.83438082794, 33850.153746156546, 34264.828675856465, 34350.312993739484, 34548.481772772924, 26143.346416339744, 26256.60615090737, 26493.091241292863, 26703.59944600794, 26794.866025670526], "unit": "score", "name": "ext.html", "value": 19370.786316087775}, {"lowerIsBetter": false, "replicates": [379.89537959703244, 381.6107570278316, 384.5904112120591, 389.0, 391.2722336454193, 17898.642027159465, 17926.37257695981, 18568.72146917794, 18577.90711046446, 18583.256669733193, 16303.91848040761, 17810.821891781077, 18334.266629334812, 18363.265469381244, 18397.63204735908, 5169.457206993258, 5285.101532739424, 5317.8936421271555, 5319.281896943901, 5321.255024296602, 4011.7994100295014, 5440.809571664992, 5671.149327600872, 5677.460641239076, 5680.715964201794, 5649.943500564983, 5652.265205523297, 5653.349864765543, 5673.149027645865, 5674.631148975324, 5921.526277897758, 5973.701314934257, 6136.509079273647, 6145.846353841145, 6146.508279337642, 5483.369412517532, 5485.890282194334, 5486.91769623456, 5496.340439147288, 5500.4224556421395, 13764.17414955096, 14136.0, 14148.292585370793, 14150.504732334319, 14177.43290268388, 2339.02930283932, 2388.653645221433, 2406.7352591214953, 2408.879556022192, 2495.7753802157895, 10535.63125290611, 11928.522859085626, 13131.60605181846, 13728.794068088986, 14084.647883802987, 1888.33908132154, 1903.80010098939, 1911.6081203353278, 1921.8366438852715, 1924.0956750327323, 66890.0, 68239.0, 68347.31652683509, 68556.97164542586, 68635.0, 10946.781064378667, 11121.165912556591, 11123.110151188048, 11176.32942023465, 11269.718257043476, 14655.926720366544, 14808.851911480962, 14875.628109297355, 14895.47865824691, 14904.0, 8222.301104406193, 8329.292010179082, 8333.125021872738, 8377.37169712274, 8453.492790432594, 7764.534127952341, 7773.144954055049, 7865.764027079197, 7889.132195458495, 7961.681532738626, 4671.369365135731, 4752.52474752522, 4806.7836947337455, 4807.95192048082, 4812.639052071108, 1791.167107295114, 1804.4906766350678, 1874.4376686993846, 1898.6012937283049, 1905.1998160772232, 482.7634459115008, 484.2663365002025, 1000.8124124662827, 1033.6640591807693, 1088.7768007558432, 11684.649460516199, 11944.880551194377, 12122.212056216318, 12152.817707734392, 12231.816522752166, 494.92823540587136, 498.5637567128762, 520.292402332827, 524.446708722294, 539.094321539809, 6472.704147538673, 6500.674966251669, 6549.410553050248, 6625.17185351831, 6709.597424154566, 434934.0, 444139.0, 447213.0, 448968.0, 451324.0, 66372.33627663758, 68075.65962170158, 77447.0, 78636.60681696555, 78978.6051069741, 1105.5909313553875, 1113.04834366617, 1142.1890457775073, 1181.6809461445362, 1185.4369174641977, 15995.440159594824, 16004.599885002503, 16202.432914848396, 16253.349866005228, 16390.508284751475, 32282.19294517562, 32980.83509582437, 33145.83427082849, 34584.96245112651, 34592.0, 38613.613863861, 46474.0, 47215.29177062278, 47473.28790068083, 49075.0, 8377.287930525974, 8446.788830279293, 8643.783905402415, 8687.261582765283, 8757.47455152693, 12231.571894983634, 12603.684907877376, 12760.872391275969, 13024.283664398548, 13569.457221711022, 10056.145227655732, 10694.091002264895, 10724.624638137628, 10884.292520986111, 11041.0, 9787.608495660093, 9912.553935073083, 9930.702078937644, 10315.48422578883, 10638.095761860328, 10627.574897004033, 10755.784884302113, 10806.0, 10900.7274818127, 11042.834357484484, 8385.664573416994, 8435.746927592181, 8521.659133634585, 8530.530820804915, 8616.956915215384, 9702.660406886007, 10602.8939710605, 10733.785324293627, 10787.0, 10958.890411095786], "unit": "score", "name": "jquery.html", "value": 8312.27927630693}, {"lowerIsBetter": false, "replicates": [1544.4825983295596, 1551.7517197248442, 1574.6063484128968, 1786.6694661487625, 1902.6670332691783, 7150.320719531643, 7852.725154619582, 8017.278444939954, 8030.437869349148, 8038.47749896257, 7864.803379915505, 8020.2380773826535, 8025.438219324635, 8029.35765138789, 8039.839203215932, 2101.0, 2152.1068756466047, 2366.988165059181, 2416.2992732107714, 2448.0574978633176, 2438.1100898172126, 2451.669024681663, 2451.950960980779, 2452.3378687754384, 2456.2140115163156, 2374.0622454130607, 2400.2679182849224, 2415.0, 2416.9879150604224, 2417.806575473967, 2361.2916125162556, 2406.9518609627885, 2408.7350391456926, 2422.915197968063, 2424.62418325159, 2394.928152155438, 2419.600765873629, 2427.781499665021, 2428.271518544447, 2430.6961629796274, 8195.016598008218, 8262.876056859091, 8264.628091735825, 8266.090730019692, 8266.462679925786, 5042.344495215599, 5147.794088236466, 5148.150555158394, 5188.429272779991, 5193.68837869729, 3265.2163480764684, 3284.8521816518314, 3341.148007258158, 3378.4932260160926, 3437.8281085945605, 985.65009421655, 987.6888780034266, 1019.3119644240182, 1021.0912288063629, 1032.7727899862093, 11437.0, 11439.370834604093, 11445.25605835618, 11460.541578336857, 11461.484233209525, 4594.908101837945, 4668.836590719308, 4727.479977202505, 4756.143894099096, 4773.1408346497965, 9092.27261819053, 9093.31800114994, 9155.908440915638, 9174.082591740906, 9178.770530736785, 5089.465606111379, 5090.618203634742, 5090.872728181751, 5096.388433388017, 5099.56653684441, 4174.645155161785, 4552.0668263006, 4585.151746926763, 4649.139909116757, 4711.811527538928, 3710.3135919854913, 3797.5063241778394, 3815.065308999313, 3819.197968426606, 3892.2215556888737, 1105.8396532502902, 1130.1806190511813, 1130.3387518301886, 1131.6209069961656, 1133.8072527670151, 1453.273363318341, 1456.3009755317507, 1459.912405255688, 1479.0090639271714, 1481.3111902965172, 7867.095284042294, 7921.405894557931, 7964.362850971908, 7969.641366138538, 7980.281774640194, 530.8327876718821, 538.3270911360798, 540.608059157108, 542.1731858915107, 543.8857839853596, 5909.881802363929, 5927.1405646181065, 5955.196048533393, 5986.072158815304, 5987.191729116601, 9644.132028117503, 10244.948775256225, 10255.58977640901, 10291.073803357735, 10292.125169360539, 9733.805323893625, 9919.355241909252, 10064.69805905824, 10070.244731645156, 10143.898561014443, 7617.238276172449, 7728.806779830549, 7764.767056988299, 7795.532268063935, 7812.257835505618, 7548.0, 7551.0, 7576.393888489018, 7611.0, 7728.072631284282, 8758.386912916034, 8834.381593288665, 8965.551722413722, 9008.729738107868, 9072.364934454788, 9070.727878163665, 9074.274058075207, 9129.224015958718, 9301.255899528156, 9312.953435232781, 6359.55483116196, 6617.867642647217, 6723.125993620798, 7054.25930277334, 7171.067761191011, 7652.464327497022, 7660.923390766244, 7665.463417560717, 7695.422843286664, 7707.34487568563, 6695.564788288746, 6801.761938332134, 6807.183138023469, 6961.721531138698, 7008.299170082951, 6649.368310010541, 6695.899561506679, 6718.798436046926, 6828.795136145924, 6844.965775171092, 7238.819029524093, 7314.597697126496, 7333.0, 7352.080989876265, 7361.30067643573, 6733.192016957801, 6744.763933262312, 6772.255051944184, 6781.457483401217, 6786.151731033621, 6687.097241872285, 6753.088333074972, 6762.985552167214, 6778.830529236611, 6787.151606049244], "unit": "score", "name": "mootools.html", "value": 4620.34878948284}, {"lowerIsBetter": false, "replicates": [360.4521127885614, 367.1537106968437, 367.20683324020087, 367.3882984830258, 370.684917819853, 6009.519238460924, 6032.276126864777, 6052.546059045578, 6063.333033366326, 6087.026075827868, 5968.850778730534, 5983.880322393549, 5989.610675306102, 5995.700214989244, 6022.759089636409, 4501.572350626693, 4590.173768721629, 4676.69601475903, 4726.976365118169, 4727.66906316558, 4688.156131896258, 4723.834665786698, 4728.716277023373, 4729.6452766042685, 4729.9763501182615, 4452.910941781162, 4695.9530404696025, 4700.200965835799, 4700.200965835799, 4711.29330600411, 4533.3426653135275, 4639.721616702992, 4640.09518143962, 4669.2062349400685, 4694.859154225379, 4149.107941792529, 4153.7300075494995, 4154.044569748975, 4162.979185104085, 4166.375043743433, 5741.282339707536, 5745.770169193227, 5748.16651585522, 5750.5687073469235, 5753.1370294456165, 5441.945580544223, 5448.210009548593, 5449.04641687703, 5449.618526703132, 5459.672419654833, 6301.306856245809, 6303.810885673392, 6309.305976342599, 6311.747530098791, 6312.0, 4514.097180563867, 4635.791389387486, 4642.396488456513, 4644.326572646947, 4650.86047418578, 6545.345465453464, 6627.337266273383, 6650.268470468244, 6651.035599838045, 6654.567453115532, 4763.857084287408, 4776.188048031843, 4777.665563410528, 4781.402324709411, 4788.928166077511, 4849.175640141114, 4850.6362022847725, 4853.878653033632, 4855.490173531799, 4855.708657480563, 5473.17902314656, 5482.314710661168, 5482.588805839578, 5489.780408783604, 5490.203920431515, 6254.906176407358, 6400.943844265737, 6408.295087540367, 6416.390442908009, 6431.324710905381, 1693.9237734301987, 1700.0819557439092, 1711.9743203851951, 1712.289399899028, 1712.6831536165848, 1079.6868908016745, 1154.1401655766508, 1154.9884501154881, 1184.5972369394447, 1188.0970462448429, 6038.969805151034, 6087.817365479043, 6095.481884039907, 6098.573099882966, 6111.236095488064, 6517.837054073591, 6557.409833115043, 6580.11168492257, 6583.934160658428, 6588.439982601532, 6043.8186854394435, 6045.0, 6084.604500707528, 6090.086487026982, 6091.695415229221, 3521.0669172669263, 3557.092941299952, 3557.1640664443835, 3557.288542291552, 3559.501669766235, 6628.767993120314, 6781.593104413751, 6783.62690052042, 6790.219124800612, 6791.796246112525, 6675.365840245169, 6682.732690692415, 6701.061851340816, 6706.631135287606, 6720.966395167993, 6762.087118239073, 6762.628055456898, 6772.2211945625895, 6774.83062923421, 6775.93224067753, 6554.606723596599, 6554.63949482783, 6557.606543607399, 6559.442447391834, 6559.770408035696, 6329.309888485513, 6438.90341644885, 6446.903296450463, 6466.4503517201565, 6467.482601391972, 6746.763863264762, 6766.391024807791, 6783.321667833177, 6786.898196526958, 6798.592084474947, 4685.273782563708, 4687.39063921688, 4690.507496712796, 4691.976540117277, 4693.483716791218, 6540.672966351759, 6542.0, 6548.967255163694, 6552.803415897531, 6554.705038273194, 6231.1276421300145, 6366.840828979312, 6368.77709280173, 6374.840628984312, 6379.936200637934, 6436.356364363526, 6473.611583305017, 6493.805185844432, 6498.675066246763, 6552.606843589209, 6410.166678331787, 6411.903821442589, 6415.390537898892, 6417.197850268716, 6421.133147025092, 6515.218173819172, 6517.967410162919, 6528.4984453575, 6528.771492997722, 6539.444147247537, 6083.878322433615, 6207.844803879759, 6225.626462412089, 6356.77751278703, 6387.105805187371], "unit": "score", "name": "prototype.html", "value": 4885.055896568428}, {"lowerIsBetter": false, "replicates": [836.2300129109146, 842.9704960326386, 861.9655213791448, 869.0961400143851, 879.1735768377724, 14715.0, 14762.852371476281, 14785.408583656641, 14790.482333118343, 14813.925930370333, 13720.176789392643, 13775.173489590607, 13822.0, 14551.345189466472, 15515.379384824622, 922.6908985489869, 931.7065124485765, 933.0529512544772, 937.634322614181, 938.713692323841, 915.9771005724843, 918.7381596245071, 919.7010971434278, 922.1331947968888, 922.1331947968921, 979.6620166042704, 985.4235272365675, 985.9844360308894, 986.5018165826248, 986.6891929042365, 972.6449845806301, 973.790635013472, 975.8243516167087, 975.8585005174245, 975.8877729061178, 720.5820624038046, 722.6386806596702, 723.3309189000206, 723.5188599581272, 724.1201939643306, 14212.360443780055, 14427.639309017359, 14427.927860360736, 14490.56528304142, 14496.275186240646, 13760.17438953666, 13878.167309961334, 14032.508862189774, 14062.085964412281, 14115.294235288195, 11540.711482212928, 11610.825837612443, 11638.243514171552, 11694.12294077939, 11704.414779261004, 3954.3079961006997, 3979.602039796026, 4003.499562554681, 4011.919761604781, 4064.3903414488063, 48643.27035094477, 48791.26813097807, 48939.0, 55309.0, 55749.0, 10877.564897404174, 11213.66359009231, 11280.323180609026, 11466.54133834654, 11580.305181688957, 19976.90011549933, 19983.800161998195, 20026.499337516678, 20045.899770501055, 20068.096935637932, 8578.656853725906, 8595.527246001406, 8647.610857511301, 8730.607122679494, 8811.911880881238, 4635.629149668019, 4679.134360143385, 4742.502037286035, 4761.785719642625, 4774.427068751703, 3437.9828100859336, 3481.1819222482695, 3483.4774783782636, 3491.94762078569, 3495.265994141208, 597.8176656119925, 608.057510858168, 614.9323574406811, 616.0297531388081, 632.077167335695, 735.9843416085768, 751.7293774241268, 769.4767558060572, 775.097011981047, 788.247223901173, 8888.155625215593, 9184.540772961325, 9338.486383248986, 9690.12788848993, 9693.9030609693, 644.1014784375769, 758.2531206761336, 768.8577613141475, 773.5977291808229, 795.8090058385945, 3978.661813745864, 4070.0, 4146.129312844276, 4248.85129020489, 4295.892602684958, 57727.0, 57876.0, 58105.128423073686, 58430.0, 58456.4154358451, 52245.2163217552, 53459.46540534545, 53667.46332536625, 54223.186652200246, 54286.0, 43369.50708062366, 44019.33970990438, 46040.53959460362, 49667.25499117516, 51121.74439127855, 8563.700270490503, 8755.781105472413, 8787.428817126865, 8838.469691818511, 8973.05782892813, 35245.47131792974, 36172.81913590521, 36372.27255454929, 36748.63251367452, 36850.8157459211, 44432.33351499795, 45478.0, 46855.0, 46869.765651171525, 47037.059258815316, 10848.566057357617, 11065.114790816555, 11305.660830175108, 11352.262102963281, 11612.303261804318, 12558.120931534704, 13113.213207207598, 13227.206367617973, 13231.073824832169, 13733.862661373258, 11908.345041022827, 11970.700732481757, 12124.818127727915, 12765.93617031909, 12975.675608109872, 11366.0, 11378.374189419661, 11526.827097593376, 11700.35648039366, 12371.0, 11384.203105782515, 12010.159288850045, 12093.69765755828, 12368.567100151451, 12546.1844980076, 10427.739306517398, 10455.059044686015, 10607.204459665401, 10655.20085993569, 10985.121190304917, 10316.742081447723, 10461.0, 10470.11004064663, 10535.525901334306, 10571.841422378517], "unit": "score", "name": "yui.html", "value": 6878.537789114078}], "name": "dromaeo_css", "value": 7148.682752084674}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 111.0, 112.0, 112.0, 98.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 149.0, 169.0, 125.0, 147.0, 149.0, 125.0, 178.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 159.0, 160.0, 160.0, 159.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 78.0, 159.0, 75.0, 76.0, 76.0, 77.0, 159.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 145.0, 92.0, 92.0, 92.0, 135.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 55.0, 54.0, 57.0, 55.0, 56.0, 62.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 76.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 109.0, 127.0, 110.0, 113.0, 107.0, 110.0, 112.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.2}, {"lowerIsBetter": true, "replicates": [148.0, 134.0, 144.0, 153.0, 144.0, 136.0, 149.0, 145.0, 141.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 66.0, 66.0, 66.0, 64.0, 66.0, 66.0, 63.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1491.1000000000001}]} 13:30:58 INFO - Return code: 0 13:30:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:30:58 INFO - # TBPL SUCCESS # 13:30:58 INFO - Running post-action listener: _resource_record_post_action 13:30:58 INFO - Running post-run listener: _resource_record_post_run 13:30:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 342319104; Read time: 224; Write time: 436164 13:30:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 33853440; Read time: 0; Write time: 53204 13:30:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 251953152; Read time: 16; Write time: 317940 13:30:59 INFO - Running post-run listener: _upload_blobber_files 13:30:59 INFO - Blob upload gear active. 13:30:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:30:59 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 13:30:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:30:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:30:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:00 INFO - (blobuploader) - INFO - Done attempting. 13:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:01 INFO - (blobuploader) - INFO - Done attempting. 13:31:01 INFO - (blobuploader) - INFO - Iteration through files over. 13:31:01 INFO - Return code: 0 13:31:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:31:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:31:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b377927398c1062c7d806a4a2409c726e7d1f3c1993f1ea8ccb00f5d5a233b0ca177f9e82f66f9f2896fc9d74ac3951f45dcc3bfa464eea60bc47338ea3cfd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e192c53c3dabe009163891aba3d896e220ea911e32f287e41371959a0545f82295b606f03940a5f2cc1aa2d2bceea33591d468f094d0e19042dbc05c77532a72"} 13:31:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:31:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:31:01 INFO - Contents: 13:31:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b377927398c1062c7d806a4a2409c726e7d1f3c1993f1ea8ccb00f5d5a233b0ca177f9e82f66f9f2896fc9d74ac3951f45dcc3bfa464eea60bc47338ea3cfd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e192c53c3dabe009163891aba3d896e220ea911e32f287e41371959a0545f82295b606f03940a5f2cc1aa2d2bceea33591d468f094d0e19042dbc05c77532a72"} 13:31:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:31:01 INFO - Copying logs to upload dir... 13:31:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:31:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.250953 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-14 13:31:01.185914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 13:31:01.191621) ========= 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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b377927398c1062c7d806a4a2409c726e7d1f3c1993f1ea8ccb00f5d5a233b0ca177f9e82f66f9f2896fc9d74ac3951f45dcc3bfa464eea60bc47338ea3cfd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e192c53c3dabe009163891aba3d896e220ea911e32f287e41371959a0545f82295b606f03940a5f2cc1aa2d2bceea33591d468f094d0e19042dbc05c77532a72"} build_url:https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/Y5sOvL_BTQuSQzCgQH-0Cw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b377927398c1062c7d806a4a2409c726e7d1f3c1993f1ea8ccb00f5d5a233b0ca177f9e82f66f9f2896fc9d74ac3951f45dcc3bfa464eea60bc47338ea3cfd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e192c53c3dabe009163891aba3d896e220ea911e32f287e41371959a0545f82295b606f03940a5f2cc1aa2d2bceea33591d468f094d0e19042dbc05c77532a72"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 13:31:01.217151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:31:01.217490) ========= 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=8783db0840cc980e80bb0bd400000236-1457985713.8867-64620898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:31:01.303227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 13:31:01.303545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 13:31:01.303996) ========= ========= Total master_lag: 0.39 =========