builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1458856246.37 results: success (0) buildid: 20160324103847 builduid: 6f036b694e7143a4b6e011c7f84cc95f revision: 559a80645f20706e1eaaeed863e90c2d35ff7644 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.369862) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.370269) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.370559) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006210 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.393193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.393459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.406241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.406498) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.455394) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.455723) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.456060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.456336) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 14:50:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2016-03-24 14:50:46 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.615815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.616139) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022228 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:46.665249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 14:50:46.665654) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 559a80645f20706e1eaaeed863e90c2d35ff7644 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 559a80645f20706e1eaaeed863e90c2d35ff7644 --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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 14:50:46,859 truncating revision to first 12 chars 2016-03-24 14:50:46,859 Setting DEBUG logging. 2016-03-24 14:50:46,859 attempt 1/10 2016-03-24 14:50:46,859 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/559a80645f20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 14:50:47,709 unpacking tar archive at: mozilla-inbound-559a80645f20/testing/mozharness/ program finished with exit code 0 elapsedTime=1.145166 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 14:50:47.823420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:47.823783) ========= echo 559a80645f20706e1eaaeed863e90c2d35ff7644 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'559a80645f20706e1eaaeed863e90c2d35ff7644'] 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 559a80645f20706e1eaaeed863e90c2d35ff7644 program finished with exit code 0 elapsedTime=0.004702 script_repo_revision: '559a80645f20706e1eaaeed863e90c2d35ff7644' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:47.873059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:47.873339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 14:50:47.883298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-03-24 14:50:47.883590) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:50:48 INFO - MultiFileLogger online at 20160324 14:50:48 in /builds/slave/test-pgo 14:50:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 14:50:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:50:48 INFO - {'append_to_log': False, 14:50:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:50:48 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:50:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:50:48 INFO - 'branch': 'Mozilla-Inbound', 14:50:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:48 INFO - 'config_files': ('talos/linux_config.py',), 14:50:48 INFO - 'default_actions': ('clobber', 14:50:48 INFO - 'read-buildbot-config', 14:50:48 INFO - 'download-and-extract', 14:50:48 INFO - 'populate-webroot', 14:50:48 INFO - 'create-virtualenv', 14:50:48 INFO - 'install', 14:50:48 INFO - 'run-tests'), 14:50:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:48 INFO - 'download_minidump_stackwalk': True, 14:50:48 INFO - 'download_symbols': 'ondemand', 14:50:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:48 INFO - 'installer_path': 'installer.exe', 14:50:48 INFO - 'log_level': 'info', 14:50:48 INFO - 'log_name': 'talos', 14:50:48 INFO - 'log_to_console': True, 14:50:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:50:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:50:48 INFO - 'opt_config_files': (), 14:50:48 INFO - 'pip_index': False, 14:50:48 INFO - 'sps_profile': False, 14:50:48 INFO - 'sps_profile_interval': 0, 14:50:48 INFO - 'suite': 'dromaeojs', 14:50:48 INFO - 'system_bits': '32', 14:50:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:48 INFO - 'title': 'talos-linux64-ix-033', 14:50:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:48 INFO - 'use_talos_json': True, 14:50:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:50:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:48 INFO - 'work_dir': 'build'} 14:50:48 INFO - ##### 14:50:48 INFO - ##### Running clobber step. 14:50:48 INFO - ##### 14:50:48 INFO - Running pre-action listener: _resource_record_pre_action 14:50:48 INFO - Running main action method: clobber 14:50:48 INFO - rmtree: /builds/slave/test-pgo/build 14:50:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:50:48 INFO - Running post-action listener: _resource_record_post_action 14:50:48 INFO - ##### 14:50:48 INFO - ##### Running read-buildbot-config step. 14:50:48 INFO - ##### 14:50:48 INFO - Running pre-action listener: _resource_record_pre_action 14:50:48 INFO - Running main action method: read_buildbot_config 14:50:48 INFO - Using buildbot properties: 14:50:48 INFO - { 14:50:48 INFO - "project": "", 14:50:48 INFO - "product": "firefox", 14:50:48 INFO - "script_repo_revision": "production", 14:50:48 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 14:50:48 INFO - "repository": "", 14:50:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 14:50:48 INFO - "buildid": "20160324103847", 14:50:48 INFO - "pgo_build": "True", 14:50:48 INFO - "basedir": "/builds/slave/test-pgo", 14:50:48 INFO - "buildnumber": 1625, 14:50:48 INFO - "slavename": "talos-linux64-ix-033", 14:50:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:50:48 INFO - "platform": "ubuntu64_hw", 14:50:48 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 14:50:48 INFO - "branch": "mozilla-inbound", 14:50:48 INFO - "repo_path": "integration/mozilla-inbound", 14:50:48 INFO - "revision": "559a80645f20706e1eaaeed863e90c2d35ff7644", 14:50:48 INFO - "stage_platform": "linux64-pgo", 14:50:48 INFO - "builduid": "6f036b694e7143a4b6e011c7f84cc95f", 14:50:48 INFO - "slavebuilddir": "test" 14:50:48 INFO - } 14:50:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:50:48 INFO - Running post-action listener: _resource_record_post_action 14:50:48 INFO - ##### 14:50:48 INFO - ##### Running download-and-extract step. 14:50:48 INFO - ##### 14:50:48 INFO - Running pre-action listener: _resource_record_pre_action 14:50:48 INFO - Running main action method: download_and_extract 14:50:48 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:50:48 INFO - https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:50:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:50:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:50:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:50:49 INFO - Downloaded 1361 bytes. 14:50:49 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:50:49 INFO - Using the following test package requirements: 14:50:49 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:50:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:50:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:50:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'jsshell-linux-x86_64.zip'], 14:50:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:50:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:50:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:50:49 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:50:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:50:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:50:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:50:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:50: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')]} 14:50:49 INFO - https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:50:50 INFO - Downloaded 23657594 bytes. 14:50:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:50:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:50:51 INFO - Return code: 0 14:50:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:50: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')]} 14:50:51 INFO - https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:50:54 INFO - Downloaded 23657594 bytes. 14:50:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:50:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:50:55 INFO - Return code: 0 14:50: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')]} 14:50:55 INFO - https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:50:56 INFO - Downloaded 10847503 bytes. 14:50:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:50:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:50:56 INFO - Return code: 0 14:50:56 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')]} 14:50:56 INFO - https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:50:58 INFO - Downloaded 57732092 bytes. 14:50:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:50:58 INFO - mkdir: /builds/slave/test-pgo/properties 14:50:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:50:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:50:58 INFO - Contents: 14:50:58 INFO - build_url:https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:50:58 INFO - Running post-action listener: _resource_record_post_action 14:50:58 INFO - Running post-action listener: set_extra_try_arguments 14:50:58 INFO - ##### 14:50:58 INFO - ##### Running populate-webroot step. 14:50:58 INFO - ##### 14:50:58 INFO - Running pre-action listener: _resource_record_pre_action 14:50:58 INFO - Running main action method: populate_webroot 14:50:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:50:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:50:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:50:58 INFO - '--tppagecycles', 14:50:58 INFO - '7'], 14:50:58 INFO - 'tests': ['tsvgm']}}, 14:50:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:50:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:50:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:50:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:50:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'tests': ['damp', 'tps']}, 14:50:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['damp', 'tps']}, 14:50:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:50:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:50:58 INFO - 'other': {'tests': ['a11yr', 14:50:58 INFO - 'ts_paint', 14:50:58 INFO - 'tpaint', 14:50:58 INFO - 'sessionrestore', 14:50:58 INFO - 'sessionrestore_no_auto_restore', 14:50:58 INFO - 'tabpaint']}, 14:50:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['a11yr', 14:50:58 INFO - 'ts_paint', 14:50:58 INFO - 'tpaint', 14:50:58 INFO - 'sessionrestore', 14:50:58 INFO - 'sessionrestore_no_auto_restore', 14:50:58 INFO - 'tabpaint']}, 14:50:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['a11yr', 14:50:58 INFO - 'ts_paint', 14:50:58 INFO - 'tpaint', 14:50:58 INFO - 'sessionrestore', 14:50:58 INFO - 'sessionrestore_no_auto_restore', 14:50:58 INFO - 'tabpaint']}, 14:50:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['a11yr', 14:50:58 INFO - 'ts_paint', 14:50:58 INFO - 'tpaint', 14:50:58 INFO - 'sessionrestore', 14:50:58 INFO - 'sessionrestore_no_auto_restore', 14:50:58 INFO - 'tabpaint']}, 14:50:58 INFO - 'other_l64': {'tests': ['a11yr', 14:50:58 INFO - 'ts_paint', 14:50:58 INFO - 'tpaint', 14:50:58 INFO - 'sessionrestore', 14:50:58 INFO - 'sessionrestore_no_auto_restore', 14:50:58 INFO - 'tabpaint']}, 14:50:58 INFO - 'other_nol64': {'tests': ['a11yr', 14:50:58 INFO - 'ts_paint', 14:50:58 INFO - 'tpaint', 14:50:58 INFO - 'sessionrestore', 14:50:58 INFO - 'sessionrestore_no_auto_restore', 14:50:58 INFO - 'tabpaint']}, 14:50:58 INFO - 'svgr': {'tests': ['tsvgx', 14:50:58 INFO - 'tsvgr_opacity', 14:50:58 INFO - 'tart', 14:50:58 INFO - 'tscrollx', 14:50:58 INFO - 'cart']}, 14:50:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['tsvgx', 14:50:58 INFO - 'tsvgr_opacity', 14:50:58 INFO - 'tart', 14:50:58 INFO - 'tscrollx', 14:50:58 INFO - 'cart']}, 14:50:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'tests': ['tp5o']}, 14:50:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'talos_options': ['--e10s'], 14:50:58 INFO - 'tests': ['tp5o']}, 14:50:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'talos_options': ['--xperf_path', 14:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:58 INFO - 'tests': ['tp5n']}, 14:50:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:58 INFO - 'talos_options': ['--e10s', 14:50:58 INFO - '--xperf_path', 14:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:58 INFO - 'tests': ['tp5n']}}, 14:50:58 INFO - 'talos.zip': {'path': '', 14:50:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:50:58 INFO - Running post-action listener: _resource_record_post_action 14:50:58 INFO - ##### 14:50:58 INFO - ##### Running create-virtualenv step. 14:50:58 INFO - ##### 14:50:58 INFO - Running pre-action listener: _resource_record_pre_action 14:50:58 INFO - Running main action method: create_virtualenv 14:50:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:50:58 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 14:50:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:50:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:50:59 INFO - Using real prefix '/usr' 14:50:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:50:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:01 INFO - Installing pip.................done. 14:51:01 INFO - Return code: 0 14:51:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:51:01 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')]} 14:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:01 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')]} 14:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:01 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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:01 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 14:51:01 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 14:51:01 INFO - Using env: {'DISPLAY': ':0', 14:51:01 INFO - 'HOME': '/home/cltbld', 14:51:01 INFO - 'LANG': 'en_US.UTF-8', 14:51:01 INFO - 'LANGUAGE': 'en_US:en', 14:51:01 INFO - 'LOGNAME': 'cltbld', 14:51:01 INFO - 'MAIL': '/var/mail/cltbld', 14:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:01 INFO - 'MOZ_NO_REMOTE': '1', 14:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:01 INFO - 'NO_EM_RESTART': '1', 14:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:01 INFO - 'SHELL': '/bin/bash', 14:51:01 INFO - 'SHLVL': '1', 14:51:01 INFO - 'TERM': 'linux', 14:51:01 INFO - 'TMOUT': '86400', 14:51:01 INFO - 'USER': 'cltbld', 14:51:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:01 INFO - '_': '/tools/buildbot/bin/python'} 14:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:01 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 14:51:01 INFO - Cleaning up... 14:51:01 INFO - Return code: 0 14:51:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:51:01 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')]} 14:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:01 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')]} 14:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:01 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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:01 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 14:51:01 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 14:51:01 INFO - Using env: {'DISPLAY': ':0', 14:51:01 INFO - 'HOME': '/home/cltbld', 14:51:01 INFO - 'LANG': 'en_US.UTF-8', 14:51:01 INFO - 'LANGUAGE': 'en_US:en', 14:51:01 INFO - 'LOGNAME': 'cltbld', 14:51:01 INFO - 'MAIL': '/var/mail/cltbld', 14:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:01 INFO - 'MOZ_NO_REMOTE': '1', 14:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:01 INFO - 'NO_EM_RESTART': '1', 14:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:01 INFO - 'SHELL': '/bin/bash', 14:51:01 INFO - 'SHLVL': '1', 14:51:01 INFO - 'TERM': 'linux', 14:51:01 INFO - 'TMOUT': '86400', 14:51:01 INFO - 'USER': 'cltbld', 14:51:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:01 INFO - '_': '/tools/buildbot/bin/python'} 14:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:01 INFO - Downloading/unpacking psutil>=0.7.1 14:51:01 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 14:51:01 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 14:51:01 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 14:51:01 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 14:51:01 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 14:51:01 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 14:51:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:03 INFO - Installing collected packages: psutil 14:51:03 INFO - Running setup.py install for psutil 14:51:03 INFO - building 'psutil._psutil_linux' extension 14:51:03 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 14:51:04 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 14:51:04 INFO - building 'psutil._psutil_posix' extension 14:51:04 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 14:51:04 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 14:51:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:04 INFO - Successfully installed psutil 14:51:04 INFO - Cleaning up... 14:51:04 INFO - Return code: 0 14:51:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:04 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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:04 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 14:51:04 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 14:51:04 INFO - Using env: {'DISPLAY': ':0', 14:51:04 INFO - 'HOME': '/home/cltbld', 14:51:04 INFO - 'LANG': 'en_US.UTF-8', 14:51:04 INFO - 'LANGUAGE': 'en_US:en', 14:51:04 INFO - 'LOGNAME': 'cltbld', 14:51:04 INFO - 'MAIL': '/var/mail/cltbld', 14:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:04 INFO - 'MOZ_NO_REMOTE': '1', 14:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:04 INFO - 'NO_EM_RESTART': '1', 14:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:04 INFO - 'SHELL': '/bin/bash', 14:51:04 INFO - 'SHLVL': '1', 14:51:04 INFO - 'TERM': 'linux', 14:51:04 INFO - 'TMOUT': '86400', 14:51:04 INFO - 'USER': 'cltbld', 14:51:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:04 INFO - '_': '/tools/buildbot/bin/python'} 14:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:51:04 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 14:51:04 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 14:51:04 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 14:51:04 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 14:51:04 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 14:51:04 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 14:51:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:51:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:51:06 INFO - Installing collected packages: mozsystemmonitor 14:51:06 INFO - Running setup.py install for mozsystemmonitor 14:51:06 INFO - Successfully installed mozsystemmonitor 14:51:06 INFO - Cleaning up... 14:51:06 INFO - Return code: 0 14:51:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:51: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')]} 14:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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', '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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:51: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 blobuploader==1.2.4 14:51:06 INFO - Using env: {'DISPLAY': ':0', 14:51:06 INFO - 'HOME': '/home/cltbld', 14:51:06 INFO - 'LANG': 'en_US.UTF-8', 14:51:06 INFO - 'LANGUAGE': 'en_US:en', 14:51:06 INFO - 'LOGNAME': 'cltbld', 14:51:06 INFO - 'MAIL': '/var/mail/cltbld', 14:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:06 INFO - 'MOZ_NO_REMOTE': '1', 14:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:06 INFO - 'NO_EM_RESTART': '1', 14:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:06 INFO - 'SHELL': '/bin/bash', 14:51:06 INFO - 'SHLVL': '1', 14:51:06 INFO - 'TERM': 'linux', 14:51:06 INFO - 'TMOUT': '86400', 14:51:06 INFO - 'USER': 'cltbld', 14:51:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:06 INFO - '_': '/tools/buildbot/bin/python'} 14:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:51:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:09 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 14:51:09 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 14:51:09 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 14:51:09 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 14:51:09 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 14:51:09 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 14:51:09 INFO - Downloading docopt-0.6.1.tar.gz 14:51:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:09 INFO - Running setup.py install for blobuploader 14:51:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:51:09 INFO - Running setup.py install for requests 14:51:09 INFO - Running setup.py install for docopt 14:51:09 INFO - Successfully installed blobuploader requests docopt 14:51:09 INFO - Cleaning up... 14:51:10 INFO - Return code: 0 14:51:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:10 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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:10 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 14:51:10 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 14:51:10 INFO - Using env: {'DISPLAY': ':0', 14:51:10 INFO - 'HOME': '/home/cltbld', 14:51:10 INFO - 'LANG': 'en_US.UTF-8', 14:51:10 INFO - 'LANGUAGE': 'en_US:en', 14:51:10 INFO - 'LOGNAME': 'cltbld', 14:51:10 INFO - 'MAIL': '/var/mail/cltbld', 14:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:10 INFO - 'MOZ_NO_REMOTE': '1', 14:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:10 INFO - 'NO_EM_RESTART': '1', 14:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:10 INFO - 'SHELL': '/bin/bash', 14:51:10 INFO - 'SHLVL': '1', 14:51:10 INFO - 'TERM': 'linux', 14:51:10 INFO - 'TMOUT': '86400', 14:51:10 INFO - 'USER': 'cltbld', 14:51:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:10 INFO - '_': '/tools/buildbot/bin/python'} 14:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:51:10 INFO - Running setup.py (path:/tmp/pip-usrCOc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:51:10 INFO - Running setup.py (path:/tmp/pip-lzrJTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:51:10 INFO - Running setup.py (path:/tmp/pip-TJhp60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:51:10 INFO - Running setup.py (path:/tmp/pip-HtXuPd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:51:10 INFO - Running setup.py (path:/tmp/pip-RfBVNo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:51:10 INFO - Running setup.py (path:/tmp/pip-7qCZ0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:51:10 INFO - Running setup.py (path:/tmp/pip-llp1bj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:51:10 INFO - Running setup.py (path:/tmp/pip-n9fdnZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:51:10 INFO - Running setup.py (path:/tmp/pip-epSwMN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:51:10 INFO - Running setup.py (path:/tmp/pip-_zG3DG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:51:10 INFO - Running setup.py (path:/tmp/pip-7fktMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:51:11 INFO - Running setup.py (path:/tmp/pip-RiPVgn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:51:11 INFO - Running setup.py (path:/tmp/pip-F6Neyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:51:11 INFO - Running setup.py (path:/tmp/pip-IosU7W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:51:11 INFO - Running setup.py (path:/tmp/pip-g3qGvf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:51:11 INFO - Running setup.py (path:/tmp/pip-gLwTj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:51:11 INFO - Running setup.py (path:/tmp/pip-L9fhCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:51:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:11 INFO - Running setup.py install for manifestparser 14:51:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:51:11 INFO - Running setup.py install for mozcrash 14:51:11 INFO - Running setup.py install for mozdebug 14:51:11 INFO - Running setup.py install for mozdevice 14:51:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:51:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:51:11 INFO - Running setup.py install for mozfile 14:51:11 INFO - Running setup.py install for mozhttpd 14:51:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Running setup.py install for mozinfo 14:51:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Running setup.py install for mozInstall 14:51:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Running setup.py install for mozleak 14:51:12 INFO - Running setup.py install for mozlog 14:51:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Running setup.py install for moznetwork 14:51:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Running setup.py install for mozprocess 14:51:12 INFO - Running setup.py install for mozprofile 14:51:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Running setup.py install for mozrunner 14:51:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:51:12 INFO - Running setup.py install for mozscreenshot 14:51:13 INFO - Running setup.py install for moztest 14:51:13 INFO - Running setup.py install for mozversion 14:51:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:51:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:51:13 INFO - Cleaning up... 14:51:13 INFO - Return code: 0 14:51:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:51:13 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')]} 14:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:13 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')]} 14:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:13 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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:13 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 14:51:13 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 14:51:13 INFO - Using env: {'DISPLAY': ':0', 14:51:13 INFO - 'HOME': '/home/cltbld', 14:51:13 INFO - 'LANG': 'en_US.UTF-8', 14:51:13 INFO - 'LANGUAGE': 'en_US:en', 14:51:13 INFO - 'LOGNAME': 'cltbld', 14:51:13 INFO - 'MAIL': '/var/mail/cltbld', 14:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:13 INFO - 'MOZ_NO_REMOTE': '1', 14:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:13 INFO - 'NO_EM_RESTART': '1', 14:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:13 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:13 INFO - 'SHELL': '/bin/bash', 14:51:13 INFO - 'SHLVL': '1', 14:51:13 INFO - 'TERM': 'linux', 14:51:13 INFO - 'TMOUT': '86400', 14:51:13 INFO - 'USER': 'cltbld', 14:51:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:13 INFO - '_': '/tools/buildbot/bin/python'} 14:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:51:13 INFO - Running setup.py (path:/tmp/pip-gucOFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:51:13 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)) 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:51:13 INFO - Running setup.py (path:/tmp/pip-qU0CPN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:51:13 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)) 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:51:13 INFO - Running setup.py (path:/tmp/pip-Djz8_9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:51:13 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)) 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:51:13 INFO - Running setup.py (path:/tmp/pip-A6RmJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:51:13 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)) 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:51:13 INFO - Running setup.py (path:/tmp/pip-3mQTu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:51:13 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)) 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:51:13 INFO - Running setup.py (path:/tmp/pip-BD4W3R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:51:13 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)) 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:51:13 INFO - Running setup.py (path:/tmp/pip-Pf8jWS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:51:13 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)) 14:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:51:13 INFO - Running setup.py (path:/tmp/pip-ersBOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:51:14 INFO - Running setup.py (path:/tmp/pip-QNoQiu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:51:14 INFO - Running setup.py (path:/tmp/pip-CeSy0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:51:14 INFO - Running setup.py (path:/tmp/pip-HmkKNe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:51:14 INFO - Running setup.py (path:/tmp/pip-48IQmP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:51:14 INFO - Running setup.py (path:/tmp/pip-RsIKqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:51:14 INFO - Running setup.py (path:/tmp/pip-Wywx2_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:51:14 INFO - Running setup.py (path:/tmp/pip-rmftKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:51:14 INFO - Running setup.py (path:/tmp/pip-3MPM32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:51:14 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)) 14:51:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:51:14 INFO - Running setup.py (path:/tmp/pip-UfzmFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:51:14 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)) 14:51:14 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)) 14:51:14 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)) 14:51:14 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)) 14:51:14 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)) 14:51:14 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)) 14:51:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:16 INFO - Downloading blessings-1.6.tar.gz 14:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:16 INFO - Installing collected packages: blessings 14:51:16 INFO - Running setup.py install for blessings 14:51:16 INFO - Successfully installed blessings 14:51:16 INFO - Cleaning up... 14:51:16 INFO - Return code: 0 14:51:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:51:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:51:16 INFO - Reading from file tmpfile_stdout 14:51:16 INFO - Current package versions: 14:51:16 INFO - argparse == 1.2.1 14:51:16 INFO - blessings == 1.6 14:51:17 INFO - blobuploader == 1.2.4 14:51:17 INFO - docopt == 0.6.1 14:51:17 INFO - manifestparser == 1.1 14:51:17 INFO - mozInstall == 1.12 14:51:17 INFO - mozcrash == 0.17 14:51:17 INFO - mozdebug == 0.1 14:51:17 INFO - mozdevice == 0.48 14:51:17 INFO - mozfile == 1.2 14:51:17 INFO - mozhttpd == 0.7 14:51:17 INFO - mozinfo == 0.9 14:51:17 INFO - mozleak == 0.1 14:51:17 INFO - mozlog == 3.1 14:51:17 INFO - moznetwork == 0.27 14:51:17 INFO - mozprocess == 0.22 14:51:17 INFO - mozprofile == 0.28 14:51:17 INFO - mozrunner == 6.11 14:51:17 INFO - mozscreenshot == 0.1 14:51:17 INFO - mozsystemmonitor == 0.0 14:51:17 INFO - moztest == 0.7 14:51:17 INFO - mozversion == 1.4 14:51:17 INFO - psutil == 3.1.1 14:51:17 INFO - requests == 1.2.3 14:51:17 INFO - wsgiref == 0.1.2 14:51:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:17 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 14:51:17 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 14:51:17 INFO - Using env: {'DISPLAY': ':0', 14:51:17 INFO - 'HOME': '/home/cltbld', 14:51:17 INFO - 'LANG': 'en_US.UTF-8', 14:51:17 INFO - 'LANGUAGE': 'en_US:en', 14:51:17 INFO - 'LOGNAME': 'cltbld', 14:51:17 INFO - 'MAIL': '/var/mail/cltbld', 14:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:17 INFO - 'MOZ_NO_REMOTE': '1', 14:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:17 INFO - 'NO_EM_RESTART': '1', 14:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:17 INFO - 'SHELL': '/bin/bash', 14:51:17 INFO - 'SHLVL': '1', 14:51:17 INFO - 'TERM': 'linux', 14:51:17 INFO - 'TMOUT': '86400', 14:51:17 INFO - 'USER': 'cltbld', 14:51:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:17 INFO - '_': '/tools/buildbot/bin/python'} 14:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 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)) 14:51:17 INFO - Cleaning up... 14:51:17 INFO - Return code: 0 14:51:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:51:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:51:17 INFO - Using env: {'DISPLAY': ':0', 14:51:17 INFO - 'HOME': '/home/cltbld', 14:51:17 INFO - 'LANG': 'en_US.UTF-8', 14:51:17 INFO - 'LANGUAGE': 'en_US:en', 14:51:17 INFO - 'LOGNAME': 'cltbld', 14:51:17 INFO - 'MAIL': '/var/mail/cltbld', 14:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:17 INFO - 'MOZ_NO_REMOTE': '1', 14:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:17 INFO - 'NO_EM_RESTART': '1', 14:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:17 INFO - 'SHELL': '/bin/bash', 14:51:17 INFO - 'SHLVL': '1', 14:51:17 INFO - 'TERM': 'linux', 14:51:17 INFO - 'TMOUT': '86400', 14:51:17 INFO - 'USER': 'cltbld', 14:51:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:17 INFO - '_': '/tools/buildbot/bin/python'} 14:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:17 INFO - Downloading/unpacking jsonschema 14:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:51:19 INFO - Downloading/unpacking functools32 (from jsonschema) 14:51:19 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 14:51:19 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 14:51:19 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 14:51:19 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 14:51:19 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 14:51:19 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 14:51:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:51:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:51:19 INFO - warning: no files found matching '*.txt' 14:51:19 INFO - no previously-included directories found matching 'build' 14:51:19 INFO - no previously-included directories found matching 'dist' 14:51:19 INFO - no previously-included directories found matching '.git*' 14:51:19 INFO - Installing collected packages: jsonschema, functools32 14:51:19 INFO - Running setup.py install for functools32 14:51:19 INFO - warning: no files found matching '*.txt' 14:51:19 INFO - no previously-included directories found matching 'build' 14:51:19 INFO - no previously-included directories found matching 'dist' 14:51:19 INFO - no previously-included directories found matching '.git*' 14:51:19 INFO - Successfully installed jsonschema functools32 14:51:19 INFO - Cleaning up... 14:51:19 INFO - Return code: 0 14:51:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:51:19 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')]} 14:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:19 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')]} 14:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:19 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 0x7f8b6581af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', '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 14:51:19 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 14:51:19 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 14:51:19 INFO - Using env: {'DISPLAY': ':0', 14:51:19 INFO - 'HOME': '/home/cltbld', 14:51:19 INFO - 'LANG': 'en_US.UTF-8', 14:51:19 INFO - 'LANGUAGE': 'en_US:en', 14:51:19 INFO - 'LOGNAME': 'cltbld', 14:51:19 INFO - 'MAIL': '/var/mail/cltbld', 14:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:19 INFO - 'MOZ_NO_REMOTE': '1', 14:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:19 INFO - 'NO_EM_RESTART': '1', 14:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:19 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:19 INFO - 'SHELL': '/bin/bash', 14:51:19 INFO - 'SHLVL': '1', 14:51:19 INFO - 'TERM': 'linux', 14:51:19 INFO - 'TMOUT': '86400', 14:51:19 INFO - 'USER': 'cltbld', 14:51:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:19 INFO - '_': '/tools/buildbot/bin/python'} 14:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:20 INFO - Downloading/unpacking flake8 14:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:51:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:51:21 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 14:51:21 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 14:51:21 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 14:51:21 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 14:51:21 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 14:51:21 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 14:51:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:51:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:51:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:51:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:51:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:51:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:51:22 INFO - no previously-included directories found matching 'docs/_build' 14:51:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:51:22 INFO - Running setup.py install for pep8 14:51:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:51:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:51:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:51:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:51:22 INFO - no previously-included directories found matching 'docs/_build' 14:51:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:51:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:51:22 INFO - Cleaning up... 14:51:22 INFO - Return code: 0 14:51:22 INFO - Running post-action listener: _resource_record_post_action 14:51:22 INFO - Running post-action listener: _start_resource_monitoring 14:51:22 INFO - Starting resource monitoring. 14:51:22 INFO - ##### 14:51:22 INFO - ##### Running install step. 14:51:22 INFO - ##### 14:51:22 INFO - Running pre-action listener: _resource_record_pre_action 14:51:22 INFO - Running main action method: install 14:51:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:51:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:51:23 INFO - Reading from file tmpfile_stdout 14:51:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:51:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:51:23 INFO - Reading from file tmpfile_stdout 14:51:23 INFO - Output received: 14:51:23 INFO - Usage: mozinstall [options] installer 14:51:23 INFO - Options: 14:51:23 INFO - -h, --help show this help message and exit 14:51:23 INFO - -d DEST, --destination=DEST 14:51:23 INFO - Directory to install application into. [default: 14:51:23 INFO - "/builds/slave/test-pgo"] 14:51:23 INFO - --app=APP Application being installed. [default: firefox] 14:51:23 INFO - mkdir: /builds/slave/test-pgo/build/application 14:51:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:51:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:51:39 INFO - Reading from file tmpfile_stdout 14:51:39 INFO - Output received: 14:51:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:51:39 INFO - Running post-action listener: _resource_record_post_action 14:51:39 INFO - ##### 14:51:39 INFO - ##### Running run-tests step. 14:51:39 INFO - ##### 14:51:39 INFO - Running pre-action listener: _resource_record_pre_action 14:51:39 INFO - Running main action method: run_tests 14:51:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:51:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:51:39 INFO - Python 2.7.3 14:51:39 INFO - Return code: 0 14:51:39 INFO - grabbing minidump binary from tooltool 14:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:39 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 0x1b1b8b0>, '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 0x1b1c7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:51:39 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 14:51:39 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 14:51:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:51:39 INFO - Return code: 0 14:51:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:51:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:51:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:51:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:51:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:51:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:51:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:51:40 INFO - Return code: 0 14:51:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 14:51:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 14:51:40 INFO - Using env: {'DISPLAY': ':0', 14:51:40 INFO - 'HOME': '/home/cltbld', 14:51:40 INFO - 'LANG': 'en_US.UTF-8', 14:51:40 INFO - 'LANGUAGE': 'en_US:en', 14:51:40 INFO - 'LOGNAME': 'cltbld', 14:51:40 INFO - 'MAIL': '/var/mail/cltbld', 14:51:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:51:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:40 INFO - 'MOZ_NO_REMOTE': '1', 14:51:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:40 INFO - 'NO_EM_RESTART': '1', 14:51:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:51:40 INFO - 'SHELL': '/bin/bash', 14:51:40 INFO - 'SHLVL': '1', 14:51:40 INFO - 'TERM': 'linux', 14:51:40 INFO - 'TMOUT': '86400', 14:51:40 INFO - 'USER': 'cltbld', 14:51:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041', 14:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:40 INFO - '_': '/tools/buildbot/bin/python'} 14:51:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 14:51:40 INFO - mozversion application_buildid: 20160324103847 14:51:40 INFO - mozversion application_changeset: 559a80645f20706e1eaaeed863e90c2d35ff7644 14:51:40 INFO - mozversion application_display_name: Nightly 14:51:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:51:40 INFO - mozversion application_name: Firefox 14:51:40 INFO - mozversion application_remotingname: firefox 14:51:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:51:40 INFO - mozversion application_vendor: Mozilla 14:51:40 INFO - mozversion application_version: 48.0a1 14:51:40 INFO - mozversion platform_buildid: 20160324103847 14:51:40 INFO - mozversion platform_changeset: 559a80645f20706e1eaaeed863e90c2d35ff7644 14:51:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:51:40 INFO - mozversion platform_version: 48.0a1 14:51:40 INFO - using testdate: 1458856300 14:51:40 INFO - actual date: 1458856300 14:51:40 INFO - starting webserver on 'localhost:43809' 14:51:40 INFO - SUITE-START | Running 2 tests 14:51:40 INFO - TEST-START | dromaeo_css 14:51:40 INFO - operating with platform_type : linux_ 14:51:40 INFO - Initialising browser for dromaeo_css test... 14:51:40 INFO - TEST-INFO | started process 4285 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkBu3d4/profile http://localhost:43809/getInfo.html) 14:51:45 INFO - PROCESS | 4285 | __metrics Screen width/height:1600/1200 14:51:45 INFO - PROCESS | 4285 | colorDepth:24 14:51:45 INFO - PROCESS | 4285 | Browser inner width/height: 1024/697 14:51:45 INFO - PROCESS | 4285 | __metrics 14:51:47 ERROR - PROCESS | 4285 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:51:47 INFO - PROCESS | 4285 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:51:48 INFO - TEST-INFO | 4285: exit 0 14:51:48 INFO - Browser initialized. 14:51:48 INFO - Running cycle 1/1 for dromaeo_css test... 14:51:48 INFO - TEST-INFO | started process 4379 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkBu3d4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:59 INFO - PROCESS | 4379 | RSS: Main: 153513984 14:51:59 INFO - PROCESS | 4379 | 14:52:50 INFO - PROCESS | 4379 | 1458856370591 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] 14:54:58 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:43809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43809/tests/dromaeo/cssquery-ext.html) 14:54:59 INFO - PROCESS | 4379 | RSS: Main: 250564608 14:54:59 INFO - PROCESS | 4379 | 14:58:01 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:43809/tests/dromaeo/cssquery-ext.html (next: http://localhost:43809/tests/dromaeo/cssquery-jquery.html) 14:58:01 INFO - PROCESS | 4379 | RSS: Main: 233627648 14:58:01 INFO - PROCESS | 4379 | 15:01:03 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:43809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43809/tests/dromaeo/cssquery-mootools.html) 15:01:04 INFO - PROCESS | 4379 | RSS: Main: 236261376 15:01:04 INFO - PROCESS | 4379 | 15:04:06 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:43809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43809/tests/dromaeo/cssquery-prototype.html) 15:04:06 INFO - PROCESS | 4379 | RSS: Main: 219996160 15:04:06 INFO - PROCESS | 4379 | 15:07:09 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:43809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43809/tests/dromaeo/cssquery-yui.html) 15:07:09 INFO - PROCESS | 4379 | RSS: Main: 213934080 15:07:09 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:43809/tests/dromaeo/cssquery-yui.html (next: http://localhost:43809/tests/dromaeo/cssquery-dojo.html) 15:10:12 INFO - PROCESS | 4379 | RSS: Main: 258572288 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | __start_tp_report 15:10:12 INFO - PROCESS | 4379 | _x_x_mozilla_page_load 15:10:12 INFO - PROCESS | 4379 | _x_x_mozilla_page_load_details 15:10:12 INFO - PROCESS | 4379 | |i|pagename|runs| 15:10:12 INFO - PROCESS | 4379 | |0;dojo.html;3002.8798848046076;3061.601991741073;3091.041777049115;3093.597832281803;3117.360941007094;5055.848324550269;5069.9493005069935;5106.208537676662;5119.769610367528;5185.896282074356;5100.464451232613;5113.846584602468;5121.9487805121935;5147.485251474851;5168.431472538027;4496.348029535724;4534.34252033455;4559.384483094773;4618.630509559227;4682.29765535169;4496.280595104784;4629.467611224719;4647.209974304359;4666.580007799297;4691.624670026406;4558;4594.33382159585;4602.815887364502;4617.14582802181;4632.513586073481;4606.332081848113;4628.44458664959;4645.117427688762;4645.814167433298;4679.9298010529865;4537.500874903758;4555.339475776027;4617.607503362218;4622.214223581999;4641.141388843041;4995.475475075101;4995.600351971833;5010.3737032870895;5021.598272138257;5033.6224783141415;5364.436734142898;5379.784808607651;5382.569394448435;5389.407165211824;5419.160030195326;5326.440723723992;5401.243825864382;5408.972955135238;5421.864453388657;5448.291722076145;5087.847364579068;5092.6435149539175;5096.694198348074;5096.898062038776;5128.8461346159675;5575.470330318613;5589.888202235932;5590.888182236333;5593.8601534961135;5594.104943209067;5257.684538927677;5351.849352389255;5373.892522149613;5416.106342453451;5428.83713488596;5419.945800542023;5431.076716958127;5442.102053161184;5445.482679145475;5453.809116680976;5402;5421.376541697677;5424.376196737347;5426.321709786277;5470.206820011076;5338.225957236256;5430;5436.510714035756;5532.889342213214;5536.501714845684;4207.158568286294;4210.242156411814;4214.915701685949;4217.8523751668545;4249.511306199826;3773.113318370181;3774.7735135891935;3777.981110094432;3801.9429708554394;3803.866864659779;5058.848234552969;5241.0828105081455;5317.654352467077;5333.839984800462;5334.67991920486;5457.918131228034;5460.6996615186545;5470.425605311465;5477.068898287301;5479.726013699299;5187.610929180251;5204.869878252998;5215.035218484592;5219.582433405319;5264.5525130363585;4650.18621741194;4805.8077676892535;4853.757312134379;4880.463149053601;4898.2652602109965;5739.62692424991;5768.423157684282;5772.422757724194;5773.451522105393;5783.768649253982;5381.381141168816;5475.507204351547;5497.47773961473;5499.697516636624;5545.639533430314;5623.100303951348;5644.6613203207935;5649.774009039593;5709.68596727184;5721.5136713379825;5329.493698098674;5343.11838546651;5346.572274217975;5355.571554275726;5356.464353564613;5287.154055351125;5411.46810390167;5430.484104010113;5484.561235101102;5485.451454854483;5326.547243484192;5328;5328.946710532845;5331.866703332447;5378.784848606012;5293.602979776455;5295.364556253275;5300.1519756838725;5304.734763261744;5331.253624492651;5160.09698302788;5192.818251361185;5225.712585807817;5227.58179345659;5231.796686762143;5334.786608535615;5358.839234822962;5380.811671591476;5386.730663466733;5392.568594512508;5206.349206349207;5224.425313215467;5237.0835103857435;5244.76398562058;5286.7356632169 15:10:12 INFO - PROCESS | 4379 | |1;ext.html;542.3428266908127;567.8864227154565;568.2470726287668;581.6074149948784;607.7295603456462;30497.847510762444;39191.80404097979;39635.40546891792;39666.206675866466;39683.60316396835;42138.789306053506;42490.36264456028;42514.7874260629;42535;42551;8565.528895910707;8755.912440875574;8760.080191579887;8761.299096072298;8763.737087887343;8554.486730796141;8598.398112132154;8646.697365592205;8657.740267791945;8687.305015598737;8687.174718401742;8950.239229665454;8971.013188549254;8980.46117232965;8980.595873185723;8868.467891926504;8909.777255568597;8927.955360223223;8935.240504557121;8936.955315223448;8830.735077947671;8965.058668839743;8967.282617390592;8971.506567138806;8974.28205743539;42413.57586424127;42842.57157428417;42878.57121428808;42881;42928.35607465891;3616.4936908832783;3636.61815509373;3804.619538046201;3818.8663396781258;4320.546342634041;31669.20826979321;31971.200719982186;32245.35509289801;32259.35481290361;33097.66902330994;4348.0429815721955;4446.55534446556;4479.081788233404;4570.405847239871;4620.976895115503;296159;297943;298126;298802;299029;60955.39044609586;61995;62351.6882415585;62437.375626244066;62450.37549624446;64741.35258647447;64992;65009.67495162494;65111.67444162749;65117.67441162764;16285.185740713154;16469.176541172892;16484.83515164857;16487.093209873572;16490.34038638441;12563;12624.55814046504;12636.368181591068;12666.050046246568;12674.239545627292;18276.26805064984;20235.08942097609;20511.17955281802;20528.794712052986;20607;5696.259486266758;6513.743128435782;6678.298778628174;6822.181338239443;6867.175938887365;968.4673429613684;986.3736527305213;1020.0921180149672;1095.884932082136;1113.7382715061954;29042.709572904;31798.523022154684;32017.519737203962;32075.679243207735;32195.51706724354;1102.2064113838023;1110.539126262608;1133.5919069135105;1166.102101381931;1202.1344631865043;16417.753733694004;16687.833121668627;16774.49676509707;16826.579335516464;16923.492295231164;363026;364895;368330;368931;368981;56813.43186568164;57097.429025710044;57114.42885571091;57395.713021434625;57464.42535574591;1189.9052871358372;1361.4622224221378;1381.550995926308;1410.8659677330638;1412.4209074279702;28218.43563128767;29428.558571621015;30460.543091853197;31056.689433106283;32378.676213237566;44996.55003450054;45612.543874560826;46183.76908115438;46521.76739116283;46624.06751865012;249769;252611;253617;253633;254042;31494.842525788143;36218.818905905304;36319.63680363163;36554.451683224244;36594.63405365912;41652.58347416608;42113.789431052646;42150;42247.57752422559;42259.7887010563;37935;38531.80734096312;38777.224455510164;38862.41706374463;39925.2014959705;37442;37560.43659345167;37667.43498847574;37850.24299514049;37901;38798;39348.213035739696;39947.80026099851;40015.79992100021;40205.1958960825;30241.395172095996;32444.83777581097;33797.662023380435;35093;35146.64853351434;27139.72860271372;27486.450270994068;29348.26629334198;29404.70595294105;29679.554806677486 15:10:12 INFO - PROCESS | 4379 | |2;jquery.html;361.53362162809975;367.30029294194554;367.6672611286785;379.6052105809958;382.4168143581037;17432.91283543582;17640.91179544102;18382.724259136092;18479.168437420314;18491.53771155722;17234.138293085325;17587.56031099223;17767.64464710705;17775.466735997907;17790.733139002892;5447.863803404926;5672.06410942194;5714.314282286111;5718.885622287552;5720.056190728525;4117.300058989964;5588.748506317225;6010.669413182273;6264.123022776815;6274.027525733496;6191.257049154108;6197.16338294329;6217.098520714494;6219.346968568303;6225.3463386344465;5935.584509084366;6078.635281883101;6115.87768244637;6116.938830611726;6121.051237058263;3746.737728359016;5254.894902101936;5399.568034557226;5487.341519017744;5493.121100623881;20734.896325518428;20758.48103797402;21046.579068418698;21153.25963591267;21153.25963591267;2338.5673650374565;2341.7189937207645;2382.463945612241;2406.554787364343;2597.6752905886765;9459.952700236523;9625.422474651543;9701.369410988264;9757.804843903154;9873.160781333596;1935.94192174235;1987.8906660133687;2002.589469158819;2003.8296744776712;2055.290924631;64312;69668.6516567414;70041.64979175123;70149.64925175393;72363;10153.441560714084;10271.229657775697;10327.2959961607;10428.530716117793;10500.527476263587;14533.34599943005;14597.927010365092;14621.415143394144;14633.341499632543;14649.267536623127;7775.339096176888;8071.798205044804;8079.2324729151815;8146.2261085196815;8177.509349439053;7723.798717365637;7757.26306000929;7809.3752499799875;7844.921550784419;7863.488873223222;4504.752238626841;4521.253993091103;4570.428696412949;4601.7699115044115;4629.166749984967;1582.7151112799806;1598.5364244369234;1611.4762702121857;1815.9273629054953;1850.5651171974575;981.6613268422383;1036.8600238967642;1067.2529229539352;1074.7313171706917;1076.9623063192907;17316.913415433093;17485.562860928578;17520.912395438198;17935.641287174443;18068.277268909358;961.1397798970022;980.7253968888723;988.1353815411514;992.533509250651;1003.7540802503287;10071.24465665078;10188.439635820101;10213.234007449322;10251.948740256401;10280.868046894488;529831;533859;534373;540359;544596;79878.60060699776;81253;81814.59092704498;82250;82928;1036.409246729357;1052.7631282961272;1078.6278733836814;1087.494315143462;1092.4100985467917;15334.562737072289;15388.461403850812;15574.766378504104;16425.932314400005;16641.334346625998;34353.312933740686;34945.82527087348;35003;36796;37667.05832354104;43725.344119837595;45938.540614593425;45993.08013839638;46397;46471.30293045539;7693.230676932262;7741.341985931259;7745.883811742716;7792.532448053135;7821.960890195513;10435.895641043493;11687.88312116868;12391.256524608552;12449.875501244871;12744.490220391452;10923.508442119964;10936.617218397318;11030.22788404804;11368.090552755595;11692.123090768056;10434.373937563467;11005.944970275097;11180.385078820418;11342.262752921033;11530.59642912494;10474.633387831389;10508.369497830156;10513.421761803174;10980.725481863017;11278.830817537908;7909.299500607397;8302.958485207535;8362.12197719255;8379.790505237417;8402.87395689053;9774;10803.675889723321;10998.230123891251;11025.283356581796;11322.830157547809 15:10:12 INFO - PROCESS | 4379 | |3;mootools.html;1262.8358313419253;1431.7637589797682;1449.4564538298139;1605.8635016023638;1780.1544266473427;7733.535987840726;7898.763037108882;7903.8419231615335;7911.723089691862;7915.960420197898;7721.498102623325;7865.92134078659;7883.448158628898;7909.406794490422;7921.128675845667;2019.9697004544944;2064.7935206479306;2213.856099353545;2296.94257643559;2323.1520495019367;2327.1622216002224;2337.497438050819;2337.9649305260436;2338.3452633262714;2342.1451170322794;2234.519578290667;2278.316505048487;2291.656251562271;2292.3466811958597;2297.6783250344965;2277.863328200305;2307.3308740465245;2320.825938054644;2326.6975293211776;2330.1844354475966;2253.9436514087115;2277.692511510958;2282.897269622871;2297.4945511987335;2298.6322188449767;8089.919100808976;8168.387370947203;8174;8174.05998310196;8184.590770461453;5019.347484826985;5153.072446959546;5155.922661160085;5161.4322424533275;5161.767720452551;3226.0321903428876;3266.591676040495;3269.8365081746056;3292.539044533767;3314.96685033149;1061.973450663732;1075.978480430395;1082.9512671929704;1083.8374243863404;1087.9555626598476;10487.951204879528;10668.839967400496;10677.519511621995;10704.464776761131;10712.089472394779;4297.763623000765;4300.161468513672;4364.847230346986;4392.714473559272;4406.317020861771;8868.689595864114;8884.511351875579;8912.287017038621;8916.19754222123;8935.955320223487;4978.751062446863;5000.299958005882;5005.324281221989;5007.048660754518;5061.291419201315;4074.6129117733767;4600.263957766741;4637.304404339376;4643.419572553431;4683.414573178353;3581.982090089533;3631.8728844490843;3640.3083414151756;3640.7815531068222;3652.251288485854;1097.9011888930036;1102.9613963511238;1105.9612913547987;1114.2868564118971;1117.983230251547;1353.722486890185;1395.2605119286795;1407.9859201407855;1413.8232720909887;1426.7360538300447;7467.1039475263315;7609.6575654095695;7619.809504762426;7625.885611715828;7640.159582445926;1108.5067145120506;1117.4412793603199;1142.9085673146128;1165.0737663557493;1190.3869507203797;6182.412670796267;6188.350223226586;6216.533759968021;6227.034809604518;6237.407446292595;9357.766055848522;9810.21518278536;9833.606655733834;9939.353941993892;10081.395116293046;9876.358036727734;9920.057594528653;10015.048570385801;10040.246981476419;10045;7693.961530192313;7826.9608651957515;7843.05883293997;7866.410019248465;7894.289513943772;7498;7517.548947062975;7599.1261004982925;7603.65783539731;7654.196309387657;8897.866532001895;8952.23905968;8981.685641002534;9023.278137748834;9138.40600361001;9121.498317592595;9218.631254749735;9252.53737313145;9261.583228754856;9382.718518444457;6204;6628.701708423229;6697.397234248941;7085.681144348414;7171.533850299714;7548.358389536731;7579.5073320234005;7596.430267730053;7596.81007974805;7608.353289970414;6861.382475577222;7006.439484841302;7037.120359955005;7050.330218629222;7234.348908598251;6980.930190698231;7028.191757947697;7029.05107810439;7092.929070709227;7118.857622847618;7099.112610923635;7131;7168.319009694071;7181.928180718126;7233.0597022386755;6734.494912881455;6753.223379311442;6778.118844550177;6781.11845460087;6803.4557235422035;6801.829954250986;6809.659517024228;6821.965890170716;6860.931390686229;6900.585964842126 15:10:12 INFO - PROCESS | 4379 | |4;prototype.html;333.1836999351589;333.9014990577779;336.0975780030618;338.2305255543638;340.6780592340238;5699.544036477082;5714.857128571777;5729.971350143249;5742.655440673562;5754.683492407916;5669.206311116447;5692.146178073291;5710.828675139742;5733.827985160441;5739.196512488255;4232.640225580829;4314.201872653553;4377.233984052794;4417.955820441803;4443.066955939256;4396.230659634567;4417.11657668466;4443;4448.666350023761;4449.777511124447;4390.934135987963;4401.955980440202;4403.339499075132;4406.5593440656;4414.889627759316;4177.4778152730905;4298.441202643668;4369.6285815705705;4389.209942210401;4409.492908315553;3901.8244179012013;3905;3912.6478616924614;3913.4129880517867;3917.216556688645;5540.390557038722;5581;5588.832335029955;5597.692126933017;5599.384067752585;5155.097857874857;5159.974200128975;5162.819301324474;5164.664296820694;5166.560842328407;5970.34326224115;5975.492083172936;6018.879622407571;6039.275286965549;6045.60703554272;4208.179405016023;4246.624022743422;4264.509581398148;4318.093200427914;4337.414449049369;6283.3088360280335;6319.083732858756;6322.336154703782;6330.588511746721;6330.588511746768;4365.3670217818235;4368.410264614236;4370.8033138508845;4372.956270437318;4374.912501749947;4429.870383052301;4431.113777244564;4431.158079964796;4431.955680443154;4431.955680443219;5075;5075.213341932006;5083.034223497523;5083.085044691917;5083.517065878736;6080.817575472743;6098.72555734993;6098.969505152446;6103.725332360054;6104.084387341934;1530.5484881959849;1595.4017243533674;1600.9199540022953;1601.3514526616739;1606.5501659535348;1007.8891321954579;1066.3228849680509;1083.5394957143183;1099.3239157917824;1104.2325583719237;5863.853403664943;5875.177475153482;5877.089051197071;5877.911831322448;5888.205092312569;6175.96912015446;6177.938220617826;6182.381761823872;6215.12988181655;6236.222676537165;5928.288605367384;5937.346891841894;5939.376365481562;5940.613860099166;5943.257092863392;3307.58655168104;3327.8502467389026;3351.6480769519335;3354.178226334515;3356.81537515439;6463.935360646427;6609.900851487231;6611;6692.698828552727;6742.898856517156;6480.4815614750705;6509;6509.9023514647315;6512.413882750575;6515.967420162963;6695.765648202289;6699.9950007499265;6712.42944349726;6714.261431242559;6715;6335.113084168128;6337.081123237197;6345.650989195454;6353.555251132377;6356.936430635635;6093.512518998558;6199.938000620116;6250.593711408744;6267.592606480564;6280.497560195265;6617.305182955721;6648.468122550281;6652.667366631552;6656.2345330287635;6679.332066793282;4342.32693932441;4372.278574035248;4376.212281789181;4379.102284031829;4385.561443855589;6285.654289014148;6288.213973253343;6292.811215663537;6294.496440284858;6297.842553936188;6055.091736239599;6066.757329706762;6067.878642427215;6083.300420451527;6085.208922840179;5928.110783382527;6053.334133245427;6075.605085669417;6079.513638908965;6092.69536523181;5964.7912323068485;5987.221661184019;5994.220751302477;5998.610090344114;6000.669963152069;6104.664243466652;6121.051237058263;6138.631682099089;6141.447269745744;6156.045812899008;5657.915131272952;5775.018246898121;5937.287525496968;5937.614055086406;5941.881162376815 15:10:12 INFO - PROCESS | 4379 | |5;yui.html;768.3891306411402;803.9638216280267;818.9836203275935;819.9139090395512;821.7124006597692;12917.418716157772;13065.73868522629;13162.93418532906;13168.934155329222;13175.077744557884;12438.25370477772;12472.251664900112;12625.810612840814;12703.301318427482;13008.73982520349;663.4029373563807;671.2817285504487;818.8526065308242;820.2207902492626;826.1243082332717;836.6486075848159;837.794740288627;843.6541018182546;843.7932706486889;843.9535825529593;862.1895418306772;862.8835107260502;867.2195024477988;868.8175483148547;868.9131086891292;705.28413660135;844.0673056272822;845;865.9220670139717;866.7009881590841;626.2829060725489;629.1600713048086;629.317190847926;629.5907660021023;629.7669862150988;13510;13566.186028838301;13577;13584.524541641094;13584.524541641094;13883.305834708224;14116.223607701573;14246.572602821932;14253.144811311355;14289.499867504692;11451.599194028253;11561.710957226052;11591.130665200144;11631.592894248744;11657.125715571367;3758.9812050939845;3780.4140358244517;3820.0449887528116;3832.9808350958347;3863.03424143964;53834.73082634601;53885.92228155415;54029.45970540323;54243.457565424236;54450.18324725132;10709.143268538499;10848.67453976382;11012.229143960007;11048.171387145996;11079.556817727362;19273;19381.90309048446;19414.70877936832;19432.902835485733;19459.318923837596;8097.8380432392205;8137.633806478722;8395.24442800151;8517.74446766598;8522.65909363631;4964.60283177345;4971.204607262821;4987.825426110068;5011.899762004739;5074.4671809460215;3306.454435018243;3326.9168270793425;3354.0776286520913;3368;3378.138574663494;599.5593238969354;606.4117805728437;645.1773988165127;650.6714109374735;653.7548419342746;606.6572386601556;621.7948077134625;694.9575636545183;716.3051839715467;763.2710761223019;9276.536173191313;9418.199453046567;9432.575534100983;9471.952640236756;9565.808683826284;772.8222508822889;775.9301662850371;786.6342150899859;804.8108694456798;805.9113497515268;4335.783210839445;4382.255016647177;4416.536263692266;4516.570925762047;4518.796654150571;60000.39999600036;61243.38756612377;61374.69312653408;61540.38459615436;61563.6921815397;54412;55147;55208.72395637996;55611.165832512546;55776.442235577124;48882;49466.50533494619;49887.75056124696;50087.24869126966;50369.74815125901;8520.233179013918;8721.302295816446;8796.560171991247;8856.512891791013;8860.468371897448;36302;36959.260814784095;37893.43159852659;38262.6173738259;38350.424743629424;42314.788426058905;46942.53057469382;46993.2951005742;47350.52649473599;48494.272585911945;11006.559737610405;11107.222494425312;11369.431528423711;12063.517459301529;12128.818067728815;12175.452104655134;13137.868621313664;13218.678132186704;13534.458621655418;13625.25061121608;12569.245845249314;12575.685607859878;12617.93691031539;12894.097413180987;13581.11722738019;12555.560555380518;12592.307423091817;12618.053645976772;12636.747265054832;13199.934000329937;11959.581414650445;12230.694232643898;12307.26156430617;12345.69135771577;12594.118411711092;10813.945930270298;11003.504842282277;11139.72150696239;11233.71915702114;11376.601818936628;11147.331160130418;11164.720881978015;11181.608643697431;11203.71990700239;11228.708698499451 15:10:12 INFO - PROCESS | 4379 | __end_tp_report 15:10:12 INFO - PROCESS | 4379 | __start_cc_report 15:10:12 INFO - PROCESS | 4379 | _x_x_mozilla_cycle_collect,772 15:10:12 INFO - PROCESS | 4379 | __end_cc_report 15:10:12 INFO - PROCESS | 4379 | __startTimestamp1458857412431__endTimestamp 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | ------- Summary: start ------- 15:10:12 INFO - PROCESS | 4379 | Number of tests: 6 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | [#0] dojo.html Cycles:165 Average:5074.05 Median:5286.74 stddev:558.58 (10.6%) stddev-sans-first:536.14 15:10:12 INFO - PROCESS | 4379 | Values: 3002.9 3061.6 3091.0 3093.6 3117.4 5055.8 5069.9 5106.2 5119.8 5185.9 5100.5 5113.8 5121.9 5147.5 5168.4 4496.3 4534.3 4559.4 4618.6 4682.3 4496.3 4629.5 4647.2 4666.6 4691.6 4558.0 4594.3 4602.8 4617.1 4632.5 4606.3 4628.4 4645.1 4645.8 4679.9 4537.5 4555.3 4617.6 4622.2 4641.1 4995.5 4995.6 5010.4 5021.6 5033.6 5364.4 5379.8 5382.6 5389.4 5419.2 5326.4 5401.2 5409.0 5421.9 5448.3 5087.8 5092.6 5096.7 5096.9 5128.8 5575.5 5589.9 5590.9 5593.9 5594.1 5257.7 5351.8 5373.9 5416.1 5428.8 5419.9 5431.1 5442.1 5445.5 5453.8 5402.0 5421.4 5424.4 5426.3 5470.2 5338.2 5430.0 5436.5 5532.9 5536.5 4207.2 4210.2 4214.9 4217.9 4249.5 3773.1 3774.8 3778.0 3801.9 3803.9 5058.8 5241.1 5317.7 5333.8 5334.7 5457.9 5460.7 5470.4 5477.1 5479.7 5187.6 5204.9 5215.0 5219.6 5264.6 4650.2 4805.8 4853.8 4880.5 4898.3 5739.6 5768.4 5772.4 5773.5 5783.8 5381.4 5475.5 5497.5 5499.7 5545.6 5623.1 5644.7 5649.8 5709.7 5721.5 5329.5 5343.1 5346.6 5355.6 5356.5 5287.2 5411.5 5430.5 5484.6 5485.5 5326.5 5328.0 5328.9 5331.9 5378.8 5293.6 5295.4 5300.2 5304.7 5331.3 5160.1 5192.8 5225.7 5227.6 5231.8 5334.8 5358.8 5380.8 5386.7 5392.6 5206.3 5224.4 5237.1 5244.8 5286.7 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | [#1] ext.html Cycles:180 Average:48590.78 Median:38787.61 stddev:80983.73 (208.8%) stddev-sans-first:81130.56 15:10:12 INFO - PROCESS | 4379 | Values: 542.3 567.9 568.2 581.6 607.7 30497.8 39191.8 39635.4 39666.2 39683.6 42138.8 42490.4 42514.8 42535.0 42551.0 8565.5 8755.9 8760.1 8761.3 8763.7 8554.5 8598.4 8646.7 8657.7 8687.3 8687.2 8950.2 8971.0 8980.5 8980.6 8868.5 8909.8 8928.0 8935.2 8937.0 8830.7 8965.1 8967.3 8971.5 8974.3 42413.6 42842.6 42878.6 42881.0 42928.4 3616.5 3636.6 3804.6 3818.9 4320.5 31669.2 31971.2 32245.4 32259.4 33097.7 4348.0 4446.6 4479.1 4570.4 4621.0 296159.0 297943.0 298126.0 298802.0 299029.0 60955.4 61995.0 62351.7 62437.4 62450.4 64741.4 64992.0 65009.7 65111.7 65117.7 16285.2 16469.2 16484.8 16487.1 16490.3 12563.0 12624.6 12636.4 12666.1 12674.2 18276.3 20235.1 20511.2 20528.8 20607.0 5696.3 6513.7 6678.3 6822.2 6867.2 968.5 986.4 1020.1 1095.9 1113.7 29042.7 31798.5 32017.5 32075.7 32195.5 1102.2 1110.5 1133.6 1166.1 1202.1 16417.8 16687.8 16774.5 16826.6 16923.5 363026.0 364895.0 368330.0 368931.0 368981.0 56813.4 57097.4 57114.4 57395.7 57464.4 1189.9 1361.5 1381.6 1410.9 1412.4 28218.4 29428.6 30460.5 31056.7 32378.7 44996.6 45612.5 46183.8 46521.8 46624.1 249769.0 252611.0 253617.0 253633.0 254042.0 31494.8 36218.8 36319.6 36554.5 36594.6 41652.6 42113.8 42150.0 42247.6 42259.8 37935.0 38531.8 38777.2 38862.4 39925.2 37442.0 37560.4 37667.4 37850.2 37901.0 38798.0 39348.2 39947.8 40015.8 40205.2 30241.4 32444.8 33797.7 35093.0 35146.6 27139.7 27486.5 29348.3 29404.7 29679.6 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | [#2] jquery.html Cycles:180 Average:28736.11 Median:34974.41 stddev:87856.12 (251.2%) stddev-sans-first:88076.74 15:10:12 INFO - PROCESS | 4379 | Values: 361.5 367.3 367.7 379.6 382.4 17432.9 17640.9 18382.7 18479.2 18491.5 17234.1 17587.6 17767.6 17775.5 17790.7 5447.9 5672.1 5714.3 5718.9 5720.1 4117.3 5588.7 6010.7 6264.1 6274.0 6191.3 6197.2 6217.1 6219.3 6225.3 5935.6 6078.6 6115.9 6116.9 6121.1 3746.7 5254.9 5399.6 5487.3 5493.1 20734.9 20758.5 21046.6 21153.3 21153.3 2338.6 2341.7 2382.5 2406.6 2597.7 9460.0 9625.4 9701.4 9757.8 9873.2 1935.9 1987.9 2002.6 2003.8 2055.3 64312.0 69668.7 70041.6 70149.6 72363.0 10153.4 10271.2 10327.3 10428.5 10500.5 14533.3 14597.9 14621.4 14633.3 14649.3 7775.3 8071.8 8079.2 8146.2 8177.5 7723.8 7757.3 7809.4 7844.9 7863.5 4504.8 4521.3 4570.4 4601.8 4629.2 1582.7 1598.5 1611.5 1815.9 1850.6 981.7 1036.9 1067.3 1074.7 1077.0 17316.9 17485.6 17520.9 17935.6 18068.3 961.1 980.7 988.1 992.5 1003.8 10071.2 10188.4 10213.2 10251.9 10280.9 529831.0 533859.0 534373.0 540359.0 544596.0 79878.6 81253.0 81814.6 82250.0 82928.0 1036.4 1052.8 1078.6 1087.5 1092.4 15334.6 15388.5 15574.8 16425.9 16641.3 34353.3 34945.8 35003.0 36796.0 37667.1 43725.3 45938.5 45993.1 46397.0 46471.3 7693.2 7741.3 7745.9 7792.5 7822.0 10435.9 11687.9 12391.3 12449.9 12744.5 10923.5 10936.6 11030.2 11368.1 11692.1 10434.4 11005.9 11180.4 11342.3 11530.6 10474.6 10508.4 10513.4 10980.7 11278.8 7909.3 8303.0 8362.1 8379.8 8402.9 9774.0 10803.7 10998.2 11025.3 11322.8 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | [#3] mootools.html Cycles:180 Average:5650.98 Median:6196.18 stddev:2922.72 (47.2%) stddev-sans-first:2912.30 15:10:12 INFO - PROCESS | 4379 | Values: 1262.8 1431.8 1449.5 1605.9 1780.2 7733.5 7898.8 7903.8 7911.7 7916.0 7721.5 7865.9 7883.4 7909.4 7921.1 2020.0 2064.8 2213.9 2296.9 2323.2 2327.2 2337.5 2338.0 2338.3 2342.1 2234.5 2278.3 2291.7 2292.3 2297.7 2277.9 2307.3 2320.8 2326.7 2330.2 2253.9 2277.7 2282.9 2297.5 2298.6 8089.9 8168.4 8174.0 8174.1 8184.6 5019.3 5153.1 5155.9 5161.4 5161.8 3226.0 3266.6 3269.8 3292.5 3315.0 1062.0 1076.0 1083.0 1083.8 1088.0 10488.0 10668.8 10677.5 10704.5 10712.1 4297.8 4300.2 4364.8 4392.7 4406.3 8868.7 8884.5 8912.3 8916.2 8936.0 4978.8 5000.3 5005.3 5007.0 5061.3 4074.6 4600.3 4637.3 4643.4 4683.4 3582.0 3631.9 3640.3 3640.8 3652.3 1097.9 1103.0 1106.0 1114.3 1118.0 1353.7 1395.3 1408.0 1413.8 1426.7 7467.1 7609.7 7619.8 7625.9 7640.2 1108.5 1117.4 1142.9 1165.1 1190.4 6182.4 6188.4 6216.5 6227.0 6237.4 9357.8 9810.2 9833.6 9939.4 10081.4 9876.4 9920.1 10015.0 10040.2 10045.0 7694.0 7827.0 7843.1 7866.4 7894.3 7498.0 7517.5 7599.1 7603.7 7654.2 8897.9 8952.2 8981.7 9023.3 9138.4 9121.5 9218.6 9252.5 9261.6 9382.7 6204.0 6628.7 6697.4 7085.7 7171.5 7548.4 7579.5 7596.4 7596.8 7608.4 6861.4 7006.4 7037.1 7050.3 7234.3 6980.9 7028.2 7029.1 7092.9 7118.9 7099.1 7131.0 7168.3 7181.9 7233.1 6734.5 6753.2 6778.1 6781.1 6803.5 6801.8 6809.7 6822.0 6860.9 6900.6 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | [#4] prototype.html Cycles:180 Average:5120.64 Median:5764.85 stddev:1537.82 (26.7%) stddev-sans-first:1499.56 15:10:12 INFO - PROCESS | 4379 | Values: 333.2 333.9 336.1 338.2 340.7 5699.5 5714.9 5730.0 5742.7 5754.7 5669.2 5692.1 5710.8 5733.8 5739.2 4232.6 4314.2 4377.2 4418.0 4443.1 4396.2 4417.1 4443.0 4448.7 4449.8 4390.9 4402.0 4403.3 4406.6 4414.9 4177.5 4298.4 4369.6 4389.2 4409.5 3901.8 3905.0 3912.6 3913.4 3917.2 5540.4 5581.0 5588.8 5597.7 5599.4 5155.1 5160.0 5162.8 5164.7 5166.6 5970.3 5975.5 6018.9 6039.3 6045.6 4208.2 4246.6 4264.5 4318.1 4337.4 6283.3 6319.1 6322.3 6330.6 6330.6 4365.4 4368.4 4370.8 4373.0 4374.9 4429.9 4431.1 4431.2 4432.0 4432.0 5075.0 5075.2 5083.0 5083.1 5083.5 6080.8 6098.7 6099.0 6103.7 6104.1 1530.5 1595.4 1600.9 1601.4 1606.6 1007.9 1066.3 1083.5 1099.3 1104.2 5863.9 5875.2 5877.1 5877.9 5888.2 6176.0 6177.9 6182.4 6215.1 6236.2 5928.3 5937.3 5939.4 5940.6 5943.3 3307.6 3327.9 3351.6 3354.2 3356.8 6463.9 6609.9 6611.0 6692.7 6742.9 6480.5 6509.0 6509.9 6512.4 6516.0 6695.8 6700.0 6712.4 6714.3 6715.0 6335.1 6337.1 6345.7 6353.6 6356.9 6093.5 6199.9 6250.6 6267.6 6280.5 6617.3 6648.5 6652.7 6656.2 6679.3 4342.3 4372.3 4376.2 4379.1 4385.6 6285.7 6288.2 6292.8 6294.5 6297.8 6055.1 6066.8 6067.9 6083.3 6085.2 5928.1 6053.3 6075.6 6079.5 6092.7 5964.8 5987.2 5994.2 5998.6 6000.7 6104.7 6121.1 6138.6 6141.4 6156.0 5657.9 5775.0 5937.3 5937.6 5941.9 15:10:12 INFO - PROCESS | 4379 | 15:10:12 INFO - PROCESS | 4379 | [#5] yui.html Cycles:180 Average:14842.35 Median:25730.66 stddev:17141.09 (66.6%) stddev-sans-first:17156.59 15:10:12 INFO - PROCESS | 4379 | Values: 768.4 804.0 819.0 819.9 821.7 12917.4 13065.7 13162.9 13168.9 13175.1 12438.3 12472.3 12625.8 12703.3 13008.7 663.4 671.3 818.9 820.2 826.1 836.6 837.8 843.7 843.8 844.0 862.2 862.9 867.2 868.8 868.9 705.3 844.1 845.0 865.9 866.7 626.3 629.2 629.3 629.6 629.8 13510.0 13566.2 13577.0 13584.5 13584.5 13883.3 14116.2 14246.6 14253.1 14289.5 11451.6 11561.7 11591.1 11631.6 11657.1 3759.0 3780.4 3820.0 3833.0 3863.0 53834.7 53885.9 54029.5 54243.5 54450.2 10709.1 10848.7 11012.2 11048.2 11079.6 19273.0 19381.9 19414.7 19432.9 19459.3 8097.8 8137.6 8395.2 8517.7 8522.7 4964.6 4971.2 4987.8 5011.9 5074.5 3306.5 3326.9 3354.1 3368.0 3378.1 599.6 606.4 645.2 650.7 653.8 606.7 621.8 695.0 716.3 763.3 9276.5 9418.2 9432.6 9472.0 9565.8 772.8 775.9 786.6 804.8 805.9 4335.8 4382.3 4416.5 4516.6 4518.8 60000.4 61243.4 61374.7 61540.4 61563.7 54412.0 55147.0 55208.7 55611.2 55776.4 48882.0 49466.5 49887.8 50087.2 50369.7 8520.2 8721.3 8796.6 8856.5 8860.5 36302.0 36959.3 37893.4 38262.6 38350.4 42314.8 46942.5 46993.3 47350.5 48494.3 11006.6 11107.2 11369.4 12063.5 12128.8 12175.5 13137.9 13218.7 13534.5 13625.3 12569.2 12575.7 12617.9 12894.1 13581.1 12555.6 12592.3 12618.1 12636.7 13199.9 11959.6 12230.7 12307.3 12345.7 12594.1 10813.9 11003.5 11139.7 11233.7 11376.6 11147.3 11164.7 11181.6 11203.7 11228.7 15:10:12 INFO - PROCESS | 4379 | -------- Summary: end -------- 15:10:12 INFO - PROCESS | 4379 | 15:10:13 INFO - TEST-INFO | 4379: exit 0 15:10:13 INFO - TEST-OK | dromaeo_css | took 1112346ms 15:10:13 INFO - TEST-START | kraken 15:10:13 INFO - operating with platform_type : linux_ 15:10:13 INFO - Initialising browser for kraken test... 15:10:13 INFO - TEST-INFO | started process 4567 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiXUPzG/profile http://localhost:43809/getInfo.html) 15:10:17 INFO - PROCESS | 4567 | __metrics Screen width/height:1600/1200 15:10:17 INFO - PROCESS | 4567 | colorDepth:24 15:10:17 INFO - PROCESS | 4567 | Browser inner width/height: 1024/697 15:10:17 INFO - PROCESS | 4567 | __metrics 15:10:19 ERROR - PROCESS | 4567 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:10:19 INFO - PROCESS | 4567 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 15:10:20 INFO - TEST-INFO | 4567: exit 0 15:10:20 INFO - Browser initialized. 15:10:20 INFO - Running cycle 1/1 for kraken test... 15:10:20 INFO - TEST-INFO | started process 4653 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiXUPzG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:31 INFO - PROCESS | 4653 | RSS: Main: 153673728 15:10:31 INFO - PROCESS | 4653 | 15:10:34 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43809/tests/kraken/driver.html?testName=audio-beat-detection) 15:10:35 INFO - PROCESS | 4653 | RSS: Main: 195473408 15:10:35 INFO - PROCESS | 4653 | 15:10:37 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43809/tests/kraken/driver.html?testName=audio-dft) 15:10:38 INFO - PROCESS | 4653 | RSS: Main: 185491456 15:10:38 INFO - PROCESS | 4653 | 15:10:41 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43809/tests/kraken/driver.html?testName=audio-fft) 15:10:41 INFO - PROCESS | 4653 | RSS: Main: 170016768 15:10:41 INFO - PROCESS | 4653 | 15:10:43 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43809/tests/kraken/driver.html?testName=audio-oscillator) 15:10:44 INFO - PROCESS | 4653 | RSS: Main: 170766336 15:10:44 INFO - PROCESS | 4653 | 15:10:46 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:10:47 INFO - PROCESS | 4653 | RSS: Main: 172486656 15:10:47 INFO - PROCESS | 4653 | 15:10:50 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43809/tests/kraken/driver.html?testName=imaging-darkroom) 15:10:50 INFO - PROCESS | 4653 | RSS: Main: 173797376 15:10:50 INFO - PROCESS | 4653 | 15:10:54 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43809/tests/kraken/driver.html?testName=imaging-desaturate) 15:10:54 INFO - PROCESS | 4653 | RSS: Main: 173191168 15:10:54 INFO - PROCESS | 4653 | 15:10:57 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43809/tests/kraken/driver.html?testName=json-parse-financial) 15:10:58 INFO - PROCESS | 4653 | RSS: Main: 174399488 15:10:58 INFO - PROCESS | 4653 | 15:10:59 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:00 INFO - PROCESS | 4653 | RSS: Main: 184832000 15:11:00 INFO - PROCESS | 4653 | 15:11:01 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:02 INFO - PROCESS | 4653 | RSS: Main: 183197696 15:11:02 INFO - PROCESS | 4653 | 15:11:04 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:05 INFO - PROCESS | 4653 | RSS: Main: 195694592 15:11:05 INFO - PROCESS | 4653 | 15:11:07 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:08 INFO - PROCESS | 4653 | RSS: Main: 199426048 15:11:08 INFO - PROCESS | 4653 | 15:11:10 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:11 INFO - PROCESS | 4653 | RSS: Main: 198467584 15:11:11 INFO - PROCESS | 4653 | 15:11:12 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:43809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43809/tests/kraken/driver.html?testName=ai-astar) 15:11:13 INFO - PROCESS | 4653 | RSS: Main: 261742592 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | __start_tp_report 15:11:13 INFO - PROCESS | 4653 | _x_x_mozilla_page_load 15:11:13 INFO - PROCESS | 4653 | _x_x_mozilla_page_load_details 15:11:13 INFO - PROCESS | 4653 | |i|pagename|runs| 15:11:13 INFO - PROCESS | 4653 | |0;ai-astar;110;110;105;110;109;109;98;110;110;110 15:11:13 INFO - PROCESS | 4653 | |1;audio-beat-detection;159;135;153;173;127;157;157;135;170;128 15:11:13 INFO - PROCESS | 4653 | |2;audio-dft;161;162;161;161;161;161;159;166;160;163 15:11:13 INFO - PROCESS | 4653 | |3;audio-fft;73;73;99;106;75;72;73;131;97;73 15:11:13 INFO - PROCESS | 4653 | |4;audio-oscillator;94;93;139;93;93;94;147;94;93;137 15:11:13 INFO - PROCESS | 4653 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 15:11:13 INFO - PROCESS | 4653 | |6;imaging-darkroom;147;147;146;147;146;146;146;146;146;149 15:11:13 INFO - PROCESS | 4653 | |7;imaging-desaturate;96;95;96;96;97;96;96;96;97;95 15:11:13 INFO - PROCESS | 4653 | |8;json-parse-financial;56;55;56;56;58;56;56;64;55;54 15:11:13 INFO - PROCESS | 4653 | |9;json-stringify-tinderbox;61;62;61;62;61;61;60;62;61;61 15:11:13 INFO - PROCESS | 4653 | |10;stanford-crypto-aes;77;78;79;78;79;79;79;79;79;81 15:11:13 INFO - PROCESS | 4653 | |11;stanford-crypto-ccm;120;113;114;120;111;114;112;119;116;123 15:11:13 INFO - PROCESS | 4653 | |12;stanford-crypto-pbkdf2;146;141;145;142;141;135;140;142;140;141 15:11:13 INFO - PROCESS | 4653 | |13;stanford-crypto-sha256-iterative;64;63;66;63;64;62;69;64;62;62 15:11:13 INFO - PROCESS | 4653 | __end_tp_report 15:11:13 INFO - PROCESS | 4653 | __start_cc_report 15:11:13 INFO - PROCESS | 4653 | _x_x_mozilla_cycle_collect,1091 15:11:13 INFO - PROCESS | 4653 | __end_cc_report 15:11:13 INFO - PROCESS | 4653 | __startTimestamp1458857473096__endTimestamp 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | ------- Summary: start ------- 15:11:13 INFO - PROCESS | 4653 | Number of tests: 14 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.87 (3.5%) stddev-sans-first:4.04 15:11:13 INFO - PROCESS | 4653 | Values: 110.0 110.0 105.0 110.0 109.0 109.0 98.0 110.0 110.0 110.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:157.00 stddev:16.92 (10.8%) stddev-sans-first:17.59 15:11:13 INFO - PROCESS | 4653 | Values: 159.0 135.0 153.0 173.0 127.0 157.0 157.0 135.0 170.0 128.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 15:11:13 INFO - PROCESS | 4653 | Values: 161.0 162.0 161.0 161.0 161.0 161.0 159.0 166.0 160.0 163.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#3] audio-fft Cycles:10 Average:87.20 Median:73.00 stddev:20.26 (27.8%) stddev-sans-first:20.83 15:11:13 INFO - PROCESS | 4653 | Values: 73.0 73.0 99.0 106.0 75.0 72.0 73.0 131.0 97.0 73.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.12 (24.9%) stddev-sans-first:23.98 15:11:13 INFO - PROCESS | 4653 | Values: 94.0 93.0 139.0 93.0 93.0 94.0 147.0 94.0 93.0 137.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:11:13 INFO - PROCESS | 4653 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:11:13 INFO - PROCESS | 4653 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 149.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:11:13 INFO - PROCESS | 4653 | Values: 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 95.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.80 (5.0%) stddev-sans-first:2.96 15:11:13 INFO - PROCESS | 4653 | Values: 56.0 55.0 56.0 56.0 58.0 56.0 56.0 64.0 55.0 54.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 15:11:13 INFO - PROCESS | 4653 | Values: 61.0 62.0 61.0 62.0 61.0 61.0 60.0 62.0 61.0 61.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:1.03 (1.3%) stddev-sans-first:0.87 15:11:13 INFO - PROCESS | 4653 | Values: 77.0 78.0 79.0 78.0 79.0 79.0 79.0 79.0 79.0 81.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:117.50 stddev:4.05 (3.4%) stddev-sans-first:4.06 15:11:13 INFO - PROCESS | 4653 | Values: 120.0 113.0 114.0 120.0 111.0 114.0 112.0 119.0 116.0 123.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:141.50 stddev:2.98 (2.1%) stddev-sans-first:2.64 15:11:13 INFO - PROCESS | 4653 | Values: 146.0 141.0 145.0 142.0 141.0 135.0 140.0 142.0 140.0 141.0 15:11:13 INFO - PROCESS | 4653 | 15:11:13 INFO - PROCESS | 4653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:2.18 (3.4%) stddev-sans-first:2.32 15:11:13 INFO - PROCESS | 4653 | Values: 64.0 63.0 66.0 63.0 64.0 62.0 69.0 64.0 62.0 62.0 15:11:13 INFO - PROCESS | 4653 | -------- Summary: end -------- 15:11:13 INFO - PROCESS | 4653 | 15:11:14 INFO - TEST-INFO | 4653: exit 0 15:11:14 INFO - TEST-OK | kraken | took 60946ms 15:11:14 INFO - SUITE-END | took 1173s 15:11:14 INFO - Completed test suite (00:19:33) 15:11:14 INFO - javascript benchmark 15:11:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3002.8798848046076, 3061.601991741073, 3091.041777049115, 3093.597832281803, 3117.360941007094, 5055.848324550269, 5069.9493005069935, 5106.208537676662, 5119.769610367528, 5185.896282074356, 5100.464451232613, 5113.846584602468, 5121.9487805121935, 5147.485251474851, 5168.431472538027, 4496.348029535724, 4534.34252033455, 4559.384483094773, 4618.630509559227, 4682.29765535169, 4496.280595104784, 4629.467611224719, 4647.209974304359, 4666.580007799297, 4691.624670026406, 4558.0, 4594.33382159585, 4602.815887364502, 4617.14582802181, 4632.513586073481, 4606.332081848113, 4628.44458664959, 4645.117427688762, 4645.814167433298, 4679.9298010529865, 4537.500874903758, 4555.339475776027, 4617.607503362218, 4622.214223581999, 4641.141388843041, 4995.475475075101, 4995.600351971833, 5010.3737032870895, 5021.598272138257, 5033.6224783141415, 5364.436734142898, 5379.784808607651, 5382.569394448435, 5389.407165211824, 5419.160030195326, 5326.440723723992, 5401.243825864382, 5408.972955135238, 5421.864453388657, 5448.291722076145, 5087.847364579068, 5092.6435149539175, 5096.694198348074, 5096.898062038776, 5128.8461346159675, 5575.470330318613, 5589.888202235932, 5590.888182236333, 5593.8601534961135, 5594.104943209067, 5257.684538927677, 5351.849352389255, 5373.892522149613, 5416.106342453451, 5428.83713488596, 5419.945800542023, 5431.076716958127, 5442.102053161184, 5445.482679145475, 5453.809116680976, 5402.0, 5421.376541697677, 5424.376196737347, 5426.321709786277, 5470.206820011076, 5338.225957236256, 5430.0, 5436.510714035756, 5532.889342213214, 5536.501714845684, 4207.158568286294, 4210.242156411814, 4214.915701685949, 4217.8523751668545, 4249.511306199826, 3773.113318370181, 3774.7735135891935, 3777.981110094432, 3801.9429708554394, 3803.866864659779, 5058.848234552969, 5241.0828105081455, 5317.654352467077, 5333.839984800462, 5334.67991920486, 5457.918131228034, 5460.6996615186545, 5470.425605311465, 5477.068898287301, 5479.726013699299, 5187.610929180251, 5204.869878252998, 5215.035218484592, 5219.582433405319, 5264.5525130363585, 4650.18621741194, 4805.8077676892535, 4853.757312134379, 4880.463149053601, 4898.2652602109965, 5739.62692424991, 5768.423157684282, 5772.422757724194, 5773.451522105393, 5783.768649253982, 5381.381141168816, 5475.507204351547, 5497.47773961473, 5499.697516636624, 5545.639533430314, 5623.100303951348, 5644.6613203207935, 5649.774009039593, 5709.68596727184, 5721.5136713379825, 5329.493698098674, 5343.11838546651, 5346.572274217975, 5355.571554275726, 5356.464353564613, 5287.154055351125, 5411.46810390167, 5430.484104010113, 5484.561235101102, 5485.451454854483, 5326.547243484192, 5328.0, 5328.946710532845, 5331.866703332447, 5378.784848606012, 5293.602979776455, 5295.364556253275, 5300.1519756838725, 5304.734763261744, 5331.253624492651, 5160.09698302788, 5192.818251361185, 5225.712585807817, 5227.58179345659, 5231.796686762143, 5334.786608535615, 5358.839234822962, 5380.811671591476, 5386.730663466733, 5392.568594512508, 5206.349206349207, 5224.425313215467, 5237.0835103857435, 5244.76398562058, 5286.7356632169], "unit": "score", "name": "dojo.html", "value": 5038.189342553786}, {"lowerIsBetter": false, "replicates": [542.3428266908127, 567.8864227154565, 568.2470726287668, 581.6074149948784, 607.7295603456462, 30497.847510762444, 39191.80404097979, 39635.40546891792, 39666.206675866466, 39683.60316396835, 42138.789306053506, 42490.36264456028, 42514.7874260629, 42535.0, 42551.0, 8565.528895910707, 8755.912440875574, 8760.080191579887, 8761.299096072298, 8763.737087887343, 8554.486730796141, 8598.398112132154, 8646.697365592205, 8657.740267791945, 8687.305015598737, 8687.174718401742, 8950.239229665454, 8971.013188549254, 8980.46117232965, 8980.595873185723, 8868.467891926504, 8909.777255568597, 8927.955360223223, 8935.240504557121, 8936.955315223448, 8830.735077947671, 8965.058668839743, 8967.282617390592, 8971.506567138806, 8974.28205743539, 42413.57586424127, 42842.57157428417, 42878.57121428808, 42881.0, 42928.35607465891, 3616.4936908832783, 3636.61815509373, 3804.619538046201, 3818.8663396781258, 4320.546342634041, 31669.20826979321, 31971.200719982186, 32245.35509289801, 32259.35481290361, 33097.66902330994, 4348.0429815721955, 4446.55534446556, 4479.081788233404, 4570.405847239871, 4620.976895115503, 296159.0, 297943.0, 298126.0, 298802.0, 299029.0, 60955.39044609586, 61995.0, 62351.6882415585, 62437.375626244066, 62450.37549624446, 64741.35258647447, 64992.0, 65009.67495162494, 65111.67444162749, 65117.67441162764, 16285.185740713154, 16469.176541172892, 16484.83515164857, 16487.093209873572, 16490.34038638441, 12563.0, 12624.55814046504, 12636.368181591068, 12666.050046246568, 12674.239545627292, 18276.26805064984, 20235.08942097609, 20511.17955281802, 20528.794712052986, 20607.0, 5696.259486266758, 6513.743128435782, 6678.298778628174, 6822.181338239443, 6867.175938887365, 968.4673429613684, 986.3736527305213, 1020.0921180149672, 1095.884932082136, 1113.7382715061954, 29042.709572904, 31798.523022154684, 32017.519737203962, 32075.679243207735, 32195.51706724354, 1102.2064113838023, 1110.539126262608, 1133.5919069135105, 1166.102101381931, 1202.1344631865043, 16417.753733694004, 16687.833121668627, 16774.49676509707, 16826.579335516464, 16923.492295231164, 363026.0, 364895.0, 368330.0, 368931.0, 368981.0, 56813.43186568164, 57097.429025710044, 57114.42885571091, 57395.713021434625, 57464.42535574591, 1189.9052871358372, 1361.4622224221378, 1381.550995926308, 1410.8659677330638, 1412.4209074279702, 28218.43563128767, 29428.558571621015, 30460.543091853197, 31056.689433106283, 32378.676213237566, 44996.55003450054, 45612.543874560826, 46183.76908115438, 46521.76739116283, 46624.06751865012, 249769.0, 252611.0, 253617.0, 253633.0, 254042.0, 31494.842525788143, 36218.818905905304, 36319.63680363163, 36554.451683224244, 36594.63405365912, 41652.58347416608, 42113.789431052646, 42150.0, 42247.57752422559, 42259.7887010563, 37935.0, 38531.80734096312, 38777.224455510164, 38862.41706374463, 39925.2014959705, 37442.0, 37560.43659345167, 37667.43498847574, 37850.24299514049, 37901.0, 38798.0, 39348.213035739696, 39947.80026099851, 40015.79992100021, 40205.1958960825, 30241.395172095996, 32444.83777581097, 33797.662023380435, 35093.0, 35146.64853351434, 27139.72860271372, 27486.450270994068, 29348.26629334198, 29404.70595294105, 29679.554806677486], "unit": "score", "name": "ext.html", "value": 19316.140629973826}, {"lowerIsBetter": false, "replicates": [361.53362162809975, 367.30029294194554, 367.6672611286785, 379.6052105809958, 382.4168143581037, 17432.91283543582, 17640.91179544102, 18382.724259136092, 18479.168437420314, 18491.53771155722, 17234.138293085325, 17587.56031099223, 17767.64464710705, 17775.466735997907, 17790.733139002892, 5447.863803404926, 5672.06410942194, 5714.314282286111, 5718.885622287552, 5720.056190728525, 4117.300058989964, 5588.748506317225, 6010.669413182273, 6264.123022776815, 6274.027525733496, 6191.257049154108, 6197.16338294329, 6217.098520714494, 6219.346968568303, 6225.3463386344465, 5935.584509084366, 6078.635281883101, 6115.87768244637, 6116.938830611726, 6121.051237058263, 3746.737728359016, 5254.894902101936, 5399.568034557226, 5487.341519017744, 5493.121100623881, 20734.896325518428, 20758.48103797402, 21046.579068418698, 21153.25963591267, 21153.25963591267, 2338.5673650374565, 2341.7189937207645, 2382.463945612241, 2406.554787364343, 2597.6752905886765, 9459.952700236523, 9625.422474651543, 9701.369410988264, 9757.804843903154, 9873.160781333596, 1935.94192174235, 1987.8906660133687, 2002.589469158819, 2003.8296744776712, 2055.290924631, 64312.0, 69668.6516567414, 70041.64979175123, 70149.64925175393, 72363.0, 10153.441560714084, 10271.229657775697, 10327.2959961607, 10428.530716117793, 10500.527476263587, 14533.34599943005, 14597.927010365092, 14621.415143394144, 14633.341499632543, 14649.267536623127, 7775.339096176888, 8071.798205044804, 8079.2324729151815, 8146.2261085196815, 8177.509349439053, 7723.798717365637, 7757.26306000929, 7809.3752499799875, 7844.921550784419, 7863.488873223222, 4504.752238626841, 4521.253993091103, 4570.428696412949, 4601.7699115044115, 4629.166749984967, 1582.7151112799806, 1598.5364244369234, 1611.4762702121857, 1815.9273629054953, 1850.5651171974575, 981.6613268422383, 1036.8600238967642, 1067.2529229539352, 1074.7313171706917, 1076.9623063192907, 17316.913415433093, 17485.562860928578, 17520.912395438198, 17935.641287174443, 18068.277268909358, 961.1397798970022, 980.7253968888723, 988.1353815411514, 992.533509250651, 1003.7540802503287, 10071.24465665078, 10188.439635820101, 10213.234007449322, 10251.948740256401, 10280.868046894488, 529831.0, 533859.0, 534373.0, 540359.0, 544596.0, 79878.60060699776, 81253.0, 81814.59092704498, 82250.0, 82928.0, 1036.409246729357, 1052.7631282961272, 1078.6278733836814, 1087.494315143462, 1092.4100985467917, 15334.562737072289, 15388.461403850812, 15574.766378504104, 16425.932314400005, 16641.334346625998, 34353.312933740686, 34945.82527087348, 35003.0, 36796.0, 37667.05832354104, 43725.344119837595, 45938.540614593425, 45993.08013839638, 46397.0, 46471.30293045539, 7693.230676932262, 7741.341985931259, 7745.883811742716, 7792.532448053135, 7821.960890195513, 10435.895641043493, 11687.88312116868, 12391.256524608552, 12449.875501244871, 12744.490220391452, 10923.508442119964, 10936.617218397318, 11030.22788404804, 11368.090552755595, 11692.123090768056, 10434.373937563467, 11005.944970275097, 11180.385078820418, 11342.262752921033, 11530.59642912494, 10474.633387831389, 10508.369497830156, 10513.421761803174, 10980.725481863017, 11278.830817537908, 7909.299500607397, 8302.958485207535, 8362.12197719255, 8379.790505237417, 8402.87395689053, 9774.0, 10803.675889723321, 10998.230123891251, 11025.283356581796, 11322.830157547809], "unit": "score", "name": "jquery.html", "value": 8774.45366201223}, {"lowerIsBetter": false, "replicates": [1262.8358313419253, 1431.7637589797682, 1449.4564538298139, 1605.8635016023638, 1780.1544266473427, 7733.535987840726, 7898.763037108882, 7903.8419231615335, 7911.723089691862, 7915.960420197898, 7721.498102623325, 7865.92134078659, 7883.448158628898, 7909.406794490422, 7921.128675845667, 2019.9697004544944, 2064.7935206479306, 2213.856099353545, 2296.94257643559, 2323.1520495019367, 2327.1622216002224, 2337.497438050819, 2337.9649305260436, 2338.3452633262714, 2342.1451170322794, 2234.519578290667, 2278.316505048487, 2291.656251562271, 2292.3466811958597, 2297.6783250344965, 2277.863328200305, 2307.3308740465245, 2320.825938054644, 2326.6975293211776, 2330.1844354475966, 2253.9436514087115, 2277.692511510958, 2282.897269622871, 2297.4945511987335, 2298.6322188449767, 8089.919100808976, 8168.387370947203, 8174.0, 8174.05998310196, 8184.590770461453, 5019.347484826985, 5153.072446959546, 5155.922661160085, 5161.4322424533275, 5161.767720452551, 3226.0321903428876, 3266.591676040495, 3269.8365081746056, 3292.539044533767, 3314.96685033149, 1061.973450663732, 1075.978480430395, 1082.9512671929704, 1083.8374243863404, 1087.9555626598476, 10487.951204879528, 10668.839967400496, 10677.519511621995, 10704.464776761131, 10712.089472394779, 4297.763623000765, 4300.161468513672, 4364.847230346986, 4392.714473559272, 4406.317020861771, 8868.689595864114, 8884.511351875579, 8912.287017038621, 8916.19754222123, 8935.955320223487, 4978.751062446863, 5000.299958005882, 5005.324281221989, 5007.048660754518, 5061.291419201315, 4074.6129117733767, 4600.263957766741, 4637.304404339376, 4643.419572553431, 4683.414573178353, 3581.982090089533, 3631.8728844490843, 3640.3083414151756, 3640.7815531068222, 3652.251288485854, 1097.9011888930036, 1102.9613963511238, 1105.9612913547987, 1114.2868564118971, 1117.983230251547, 1353.722486890185, 1395.2605119286795, 1407.9859201407855, 1413.8232720909887, 1426.7360538300447, 7467.1039475263315, 7609.6575654095695, 7619.809504762426, 7625.885611715828, 7640.159582445926, 1108.5067145120506, 1117.4412793603199, 1142.9085673146128, 1165.0737663557493, 1190.3869507203797, 6182.412670796267, 6188.350223226586, 6216.533759968021, 6227.034809604518, 6237.407446292595, 9357.766055848522, 9810.21518278536, 9833.606655733834, 9939.353941993892, 10081.395116293046, 9876.358036727734, 9920.057594528653, 10015.048570385801, 10040.246981476419, 10045.0, 7693.961530192313, 7826.9608651957515, 7843.05883293997, 7866.410019248465, 7894.289513943772, 7498.0, 7517.548947062975, 7599.1261004982925, 7603.65783539731, 7654.196309387657, 8897.866532001895, 8952.23905968, 8981.685641002534, 9023.278137748834, 9138.40600361001, 9121.498317592595, 9218.631254749735, 9252.53737313145, 9261.583228754856, 9382.718518444457, 6204.0, 6628.701708423229, 6697.397234248941, 7085.681144348414, 7171.533850299714, 7548.358389536731, 7579.5073320234005, 7596.430267730053, 7596.81007974805, 7608.353289970414, 6861.382475577222, 7006.439484841302, 7037.120359955005, 7050.330218629222, 7234.348908598251, 6980.930190698231, 7028.191757947697, 7029.05107810439, 7092.929070709227, 7118.857622847618, 7099.112610923635, 7131.0, 7168.319009694071, 7181.928180718126, 7233.0597022386755, 6734.494912881455, 6753.223379311442, 6778.118844550177, 6781.11845460087, 6803.4557235422035, 6801.829954250986, 6809.659517024228, 6821.965890170716, 6860.931390686229, 6900.585964842126], "unit": "score", "name": "mootools.html", "value": 4639.120453075149}, {"lowerIsBetter": false, "replicates": [333.1836999351589, 333.9014990577779, 336.0975780030618, 338.2305255543638, 340.6780592340238, 5699.544036477082, 5714.857128571777, 5729.971350143249, 5742.655440673562, 5754.683492407916, 5669.206311116447, 5692.146178073291, 5710.828675139742, 5733.827985160441, 5739.196512488255, 4232.640225580829, 4314.201872653553, 4377.233984052794, 4417.955820441803, 4443.066955939256, 4396.230659634567, 4417.11657668466, 4443.0, 4448.666350023761, 4449.777511124447, 4390.934135987963, 4401.955980440202, 4403.339499075132, 4406.5593440656, 4414.889627759316, 4177.4778152730905, 4298.441202643668, 4369.6285815705705, 4389.209942210401, 4409.492908315553, 3901.8244179012013, 3905.0, 3912.6478616924614, 3913.4129880517867, 3917.216556688645, 5540.390557038722, 5581.0, 5588.832335029955, 5597.692126933017, 5599.384067752585, 5155.097857874857, 5159.974200128975, 5162.819301324474, 5164.664296820694, 5166.560842328407, 5970.34326224115, 5975.492083172936, 6018.879622407571, 6039.275286965549, 6045.60703554272, 4208.179405016023, 4246.624022743422, 4264.509581398148, 4318.093200427914, 4337.414449049369, 6283.3088360280335, 6319.083732858756, 6322.336154703782, 6330.588511746721, 6330.588511746768, 4365.3670217818235, 4368.410264614236, 4370.8033138508845, 4372.956270437318, 4374.912501749947, 4429.870383052301, 4431.113777244564, 4431.158079964796, 4431.955680443154, 4431.955680443219, 5075.0, 5075.213341932006, 5083.034223497523, 5083.085044691917, 5083.517065878736, 6080.817575472743, 6098.72555734993, 6098.969505152446, 6103.725332360054, 6104.084387341934, 1530.5484881959849, 1595.4017243533674, 1600.9199540022953, 1601.3514526616739, 1606.5501659535348, 1007.8891321954579, 1066.3228849680509, 1083.5394957143183, 1099.3239157917824, 1104.2325583719237, 5863.853403664943, 5875.177475153482, 5877.089051197071, 5877.911831322448, 5888.205092312569, 6175.96912015446, 6177.938220617826, 6182.381761823872, 6215.12988181655, 6236.222676537165, 5928.288605367384, 5937.346891841894, 5939.376365481562, 5940.613860099166, 5943.257092863392, 3307.58655168104, 3327.8502467389026, 3351.6480769519335, 3354.178226334515, 3356.81537515439, 6463.935360646427, 6609.900851487231, 6611.0, 6692.698828552727, 6742.898856517156, 6480.4815614750705, 6509.0, 6509.9023514647315, 6512.413882750575, 6515.967420162963, 6695.765648202289, 6699.9950007499265, 6712.42944349726, 6714.261431242559, 6715.0, 6335.113084168128, 6337.081123237197, 6345.650989195454, 6353.555251132377, 6356.936430635635, 6093.512518998558, 6199.938000620116, 6250.593711408744, 6267.592606480564, 6280.497560195265, 6617.305182955721, 6648.468122550281, 6652.667366631552, 6656.2345330287635, 6679.332066793282, 4342.32693932441, 4372.278574035248, 4376.212281789181, 4379.102284031829, 4385.561443855589, 6285.654289014148, 6288.213973253343, 6292.811215663537, 6294.496440284858, 6297.842553936188, 6055.091736239599, 6066.757329706762, 6067.878642427215, 6083.300420451527, 6085.208922840179, 5928.110783382527, 6053.334133245427, 6075.605085669417, 6079.513638908965, 6092.69536523181, 5964.7912323068485, 5987.221661184019, 5994.220751302477, 5998.610090344114, 6000.669963152069, 6104.664243466652, 6121.051237058263, 6138.631682099089, 6141.447269745744, 6156.045812899008, 5657.915131272952, 5775.018246898121, 5937.287525496968, 5937.614055086406, 5941.881162376815], "unit": "score", "name": "prototype.html", "value": 4628.104317176939}, {"lowerIsBetter": false, "replicates": [768.3891306411402, 803.9638216280267, 818.9836203275935, 819.9139090395512, 821.7124006597692, 12917.418716157772, 13065.73868522629, 13162.93418532906, 13168.934155329222, 13175.077744557884, 12438.25370477772, 12472.251664900112, 12625.810612840814, 12703.301318427482, 13008.73982520349, 663.4029373563807, 671.2817285504487, 818.8526065308242, 820.2207902492626, 826.1243082332717, 836.6486075848159, 837.794740288627, 843.6541018182546, 843.7932706486889, 843.9535825529593, 862.1895418306772, 862.8835107260502, 867.2195024477988, 868.8175483148547, 868.9131086891292, 705.28413660135, 844.0673056272822, 845.0, 865.9220670139717, 866.7009881590841, 626.2829060725489, 629.1600713048086, 629.317190847926, 629.5907660021023, 629.7669862150988, 13510.0, 13566.186028838301, 13577.0, 13584.524541641094, 13584.524541641094, 13883.305834708224, 14116.223607701573, 14246.572602821932, 14253.144811311355, 14289.499867504692, 11451.599194028253, 11561.710957226052, 11591.130665200144, 11631.592894248744, 11657.125715571367, 3758.9812050939845, 3780.4140358244517, 3820.0449887528116, 3832.9808350958347, 3863.03424143964, 53834.73082634601, 53885.92228155415, 54029.45970540323, 54243.457565424236, 54450.18324725132, 10709.143268538499, 10848.67453976382, 11012.229143960007, 11048.171387145996, 11079.556817727362, 19273.0, 19381.90309048446, 19414.70877936832, 19432.902835485733, 19459.318923837596, 8097.8380432392205, 8137.633806478722, 8395.24442800151, 8517.74446766598, 8522.65909363631, 4964.60283177345, 4971.204607262821, 4987.825426110068, 5011.899762004739, 5074.4671809460215, 3306.454435018243, 3326.9168270793425, 3354.0776286520913, 3368.0, 3378.138574663494, 599.5593238969354, 606.4117805728437, 645.1773988165127, 650.6714109374735, 653.7548419342746, 606.6572386601556, 621.7948077134625, 694.9575636545183, 716.3051839715467, 763.2710761223019, 9276.536173191313, 9418.199453046567, 9432.575534100983, 9471.952640236756, 9565.808683826284, 772.8222508822889, 775.9301662850371, 786.6342150899859, 804.8108694456798, 805.9113497515268, 4335.783210839445, 4382.255016647177, 4416.536263692266, 4516.570925762047, 4518.796654150571, 60000.39999600036, 61243.38756612377, 61374.69312653408, 61540.38459615436, 61563.6921815397, 54412.0, 55147.0, 55208.72395637996, 55611.165832512546, 55776.442235577124, 48882.0, 49466.50533494619, 49887.75056124696, 50087.24869126966, 50369.74815125901, 8520.233179013918, 8721.302295816446, 8796.560171991247, 8856.512891791013, 8860.468371897448, 36302.0, 36959.260814784095, 37893.43159852659, 38262.6173738259, 38350.424743629424, 42314.788426058905, 46942.53057469382, 46993.2951005742, 47350.52649473599, 48494.272585911945, 11006.559737610405, 11107.222494425312, 11369.431528423711, 12063.517459301529, 12128.818067728815, 12175.452104655134, 13137.868621313664, 13218.678132186704, 13534.458621655418, 13625.25061121608, 12569.245845249314, 12575.685607859878, 12617.93691031539, 12894.097413180987, 13581.11722738019, 12555.560555380518, 12592.307423091817, 12618.053645976772, 12636.747265054832, 13199.934000329937, 11959.581414650445, 12230.694232643898, 12307.26156430617, 12345.69135771577, 12594.118411711092, 10813.945930270298, 11003.504842282277, 11139.72150696239, 11233.71915702114, 11376.601818936628, 11147.331160130418, 11164.720881978015, 11181.608643697431, 11203.71990700239, 11228.708698499451], "unit": "score", "name": "yui.html", "value": 6751.73115496097}], "name": "dromaeo_css", "value": 7059.678924209498}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 109.0, 109.0, 98.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [159.0, 135.0, 153.0, 173.0, 127.0, 157.0, 157.0, 135.0, 170.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 159.0, 166.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 99.0, 106.0, 75.0, 72.0, 73.0, 131.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 139.0, 93.0, 93.0, 94.0, 147.0, 94.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 56.0, 58.0, 56.0, 56.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.2}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [120.0, 113.0, 114.0, 120.0, 111.0, 114.0, 112.0, 119.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [146.0, 141.0, 145.0, 142.0, 141.0, 135.0, 140.0, 142.0, 140.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 66.0, 63.0, 64.0, 62.0, 69.0, 64.0, 62.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1491.4}]} 15:11:14 INFO - Return code: 0 15:11:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:11:14 ERROR - # TBPL SUCCESS # 15:11:14 INFO - Running post-action listener: _resource_record_post_action 15:11:14 INFO - Running post-run listener: _resource_record_post_run 15:11:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541925376; Read time: 16; Write time: 792464 15:11:15 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251183104; Read time: 0; Write time: 477200 15:11:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290742272; Read time: 16; Write time: 315264 15:11:15 INFO - Running post-run listener: _upload_blobber_files 15:11:15 INFO - Blob upload gear active. 15:11:15 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:11:15 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 15:11:15 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 15:11:15 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 15:11:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:11:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:16 INFO - (blobuploader) - INFO - Done attempting. 15:11:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:11:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:11:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:17 INFO - (blobuploader) - INFO - Done attempting. 15:11:17 INFO - (blobuploader) - INFO - Iteration through files over. 15:11:17 INFO - Return code: 0 15:11:17 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:11:17 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:11:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71e527f90aeda847ce5c74214d43493437753129448510b349bb4fe2dd6e1355b94f2be80886bfda7fba94bdc0442951952d0b8ce13017a823f4a22c2ad8112d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17641f50b044a034e6f19274edc0f4933c3ca579edfe6a3122ae10f3d537671565729504fdf6d83596ae1611dff48927a49b0be69ab497c26d346e042640d7b9"} 15:11:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:11:17 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:11:17 INFO - Contents: 15:11:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71e527f90aeda847ce5c74214d43493437753129448510b349bb4fe2dd6e1355b94f2be80886bfda7fba94bdc0442951952d0b8ce13017a823f4a22c2ad8112d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17641f50b044a034e6f19274edc0f4933c3ca579edfe6a3122ae10f3d537671565729504fdf6d83596ae1611dff48927a49b0be69ab497c26d346e042640d7b9"} 15:11:17 INFO - Running post-run listener: copy_logs_to_upload_dir 15:11:17 INFO - Copying logs to upload dir... 15:11:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:11:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.678118 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-03-24 15:11:17.587100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 15:11:17.591064) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 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-Inbound/sha512/71e527f90aeda847ce5c74214d43493437753129448510b349bb4fe2dd6e1355b94f2be80886bfda7fba94bdc0442951952d0b8ce13017a823f4a22c2ad8112d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17641f50b044a034e6f19274edc0f4933c3ca579edfe6a3122ae10f3d537671565729504fdf6d83596ae1611dff48927a49b0be69ab497c26d346e042640d7b9"} build_url:https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/SUe_k8O7Rly956OR2VoScg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71e527f90aeda847ce5c74214d43493437753129448510b349bb4fe2dd6e1355b94f2be80886bfda7fba94bdc0442951952d0b8ce13017a823f4a22c2ad8112d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17641f50b044a034e6f19274edc0f4933c3ca579edfe6a3122ae10f3d537671565729504fdf6d83596ae1611dff48927a49b0be69ab497c26d346e042640d7b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 15:11:17.622347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 15:11:17.622753) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1458856245.814364-479731041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 15:11:17.709728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 15:11:17.710031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 15:11:17.710309) ========= ========= Total master_lag: 0.28 =========