builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1459637591.37 results: success (0) buildid: 20160402133037 builduid: e53502d3779b4e85896169471b300270 revision: 873bdc9379fda4887e4a19bfc82998276e1a65d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.372740) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.373173) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.373491) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006500 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.432077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.432406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.516673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.516975) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.569727) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.570076) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.570486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.570896) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-02 15:53:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-02 15:53:11 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.760468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.760847) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019386 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.811000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:11.811345) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 873bdc9379fda4887e4a19bfc82998276e1a65d4 --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 873bdc9379fda4887e4a19bfc82998276e1a65d4 --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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-02 15:53:11,897 truncating revision to first 12 chars 2016-04-02 15:53:11,897 Setting DEBUG logging. 2016-04-02 15:53:11,897 attempt 1/10 2016-04-02 15:53:11,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/873bdc9379fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-02 15:53:12,262 unpacking tar archive at: mozilla-inbound-873bdc9379fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:12.492816) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:12.493162) ========= echo 873bdc9379fda4887e4a19bfc82998276e1a65d4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'873bdc9379fda4887e4a19bfc82998276e1a65d4'] 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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 873bdc9379fda4887e4a19bfc82998276e1a65d4 program finished with exit code 0 elapsedTime=0.004720 script_repo_revision: '873bdc9379fda4887e4a19bfc82998276e1a65d4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:12.549879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:12.550547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 15:53:12.562683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-02 15:53:12.562979) ========= /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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:12 INFO - MultiFileLogger online at 20160402 15:53:12 in /builds/slave/test-pgo 15:53:12 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 15:53:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:53:12 INFO - {'append_to_log': False, 15:53:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:53:12 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:53:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:53:12 INFO - 'branch': 'Mozilla-Inbound', 15:53:12 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:12 INFO - 'config_files': ('talos/linux_config.py',), 15:53:12 INFO - 'default_actions': ('clobber', 15:53:12 INFO - 'read-buildbot-config', 15:53:12 INFO - 'download-and-extract', 15:53:12 INFO - 'populate-webroot', 15:53:12 INFO - 'create-virtualenv', 15:53:12 INFO - 'install', 15:53:12 INFO - 'run-tests'), 15:53:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:12 INFO - 'download_minidump_stackwalk': True, 15:53:12 INFO - 'download_symbols': 'ondemand', 15:53:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:53:12 INFO - 'tooltool.py': '/tools/tooltool.py', 15:53:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:53:12 INFO - '/tools/misc-python/virtualenv.py')}, 15:53:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:12 INFO - 'installer_path': 'installer.exe', 15:53:12 INFO - 'log_level': 'info', 15:53:12 INFO - 'log_name': 'talos', 15:53:12 INFO - 'log_to_console': True, 15:53:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:12 INFO - 'opt_config_files': (), 15:53:12 INFO - 'pip_index': False, 15:53:12 INFO - 'sps_profile': False, 15:53:12 INFO - 'sps_profile_interval': 0, 15:53:12 INFO - 'suite': 'dromaeojs', 15:53:12 INFO - 'system_bits': '32', 15:53:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:12 INFO - 'title': 'talos-linux64-ix-046', 15:53:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:12 INFO - 'use_talos_json': True, 15:53:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:53:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:12 INFO - 'work_dir': 'build'} 15:53:12 INFO - ##### 15:53:12 INFO - ##### Running clobber step. 15:53:12 INFO - ##### 15:53:12 INFO - Running pre-action listener: _resource_record_pre_action 15:53:12 INFO - Running main action method: clobber 15:53:12 INFO - rmtree: /builds/slave/test-pgo/build 15:53:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:53:13 INFO - Running post-action listener: _resource_record_post_action 15:53:13 INFO - ##### 15:53:13 INFO - ##### Running read-buildbot-config step. 15:53:13 INFO - ##### 15:53:13 INFO - Running pre-action listener: _resource_record_pre_action 15:53:13 INFO - Running main action method: read_buildbot_config 15:53:13 INFO - Using buildbot properties: 15:53:13 INFO - { 15:53:13 INFO - "project": "", 15:53:13 INFO - "product": "firefox", 15:53:13 INFO - "script_repo_revision": "production", 15:53:13 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:53:13 INFO - "repository": "", 15:53:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:53:13 INFO - "buildid": "20160402133037", 15:53:13 INFO - "pgo_build": "True", 15:53:13 INFO - "basedir": "/builds/slave/test-pgo", 15:53:13 INFO - "buildnumber": 1664, 15:53:13 INFO - "slavename": "talos-linux64-ix-046", 15:53:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:53:13 INFO - "platform": "ubuntu64_hw", 15:53:13 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:53:13 INFO - "branch": "mozilla-inbound", 15:53:13 INFO - "repo_path": "integration/mozilla-inbound", 15:53:13 INFO - "revision": "873bdc9379fda4887e4a19bfc82998276e1a65d4", 15:53:13 INFO - "stage_platform": "linux64-pgo", 15:53:13 INFO - "builduid": "e53502d3779b4e85896169471b300270", 15:53:13 INFO - "slavebuilddir": "test" 15:53:13 INFO - } 15:53:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:53:13 INFO - Running post-action listener: _resource_record_post_action 15:53:13 INFO - ##### 15:53:13 INFO - ##### Running download-and-extract step. 15:53:13 INFO - ##### 15:53:13 INFO - Running pre-action listener: _resource_record_pre_action 15:53:13 INFO - Running main action method: download_and_extract 15:53:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:53: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')]} 15:53:13 INFO - https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:24 INFO - Downloaded 1361 bytes. 15:53:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:53:24 INFO - Using the following test package requirements: 15:53:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:53:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:53:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'jsshell-linux-x86_64.zip'], 15:53:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:53:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:53:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:53:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:53:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:53:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:24 INFO - https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:25 INFO - Downloaded 23696436 bytes. 15:53:25 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'] 15:53:25 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 15:53:26 INFO - Return code: 0 15:53:26 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 15:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:26 INFO - https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:28 INFO - Downloaded 23696436 bytes. 15:53:28 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'] 15:53:28 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 15:53:29 INFO - Return code: 0 15:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:29 INFO - https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:30 INFO - Downloaded 10847584 bytes. 15:53:30 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'] 15:53:30 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 15:53:30 INFO - Return code: 0 15:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:30 INFO - https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgW0QUJREOJhjhET-1tIg/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 15:53:33 INFO - Downloaded 57646084 bytes. 15:53:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:53:33 INFO - mkdir: /builds/slave/test-pgo/properties 15:53:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:53:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:53:33 INFO - Contents: 15:53:33 INFO - build_url:https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:53:33 INFO - Running post-action listener: _resource_record_post_action 15:53:33 INFO - Running post-action listener: set_extra_try_arguments 15:53:33 INFO - ##### 15:53:33 INFO - ##### Running populate-webroot step. 15:53:33 INFO - ##### 15:53:33 INFO - Running pre-action listener: _resource_record_pre_action 15:53:33 INFO - Running main action method: populate_webroot 15:53:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:33 INFO - '--tppagecycles', 15:53:33 INFO - '7'], 15:53:33 INFO - 'tests': ['tsvgm']}}, 15:53:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:53:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:53:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'tests': ['damp', 'tps']}, 15:53:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['damp', 'tps']}, 15:53:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:53:33 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['dromaeo_dom']}, 15:53:33 INFO - 'other': {'tests': ['a11yr', 15:53:33 INFO - 'ts_paint', 15:53:33 INFO - 'tpaint', 15:53:33 INFO - 'sessionrestore', 15:53:33 INFO - 'sessionrestore_no_auto_restore', 15:53:33 INFO - 'tabpaint']}, 15:53:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['a11yr', 15:53:33 INFO - 'ts_paint', 15:53:33 INFO - 'tpaint', 15:53:33 INFO - 'sessionrestore', 15:53:33 INFO - 'sessionrestore_no_auto_restore', 15:53:33 INFO - 'tabpaint']}, 15:53:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['a11yr', 15:53:33 INFO - 'ts_paint', 15:53:33 INFO - 'tpaint', 15:53:33 INFO - 'sessionrestore', 15:53:33 INFO - 'sessionrestore_no_auto_restore', 15:53:33 INFO - 'tabpaint']}, 15:53:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['a11yr', 15:53:33 INFO - 'ts_paint', 15:53:33 INFO - 'tpaint', 15:53:33 INFO - 'sessionrestore', 15:53:33 INFO - 'sessionrestore_no_auto_restore', 15:53:33 INFO - 'tabpaint']}, 15:53:33 INFO - 'other_l64': {'tests': ['a11yr', 15:53:33 INFO - 'ts_paint', 15:53:33 INFO - 'tpaint', 15:53:33 INFO - 'sessionrestore', 15:53:33 INFO - 'sessionrestore_no_auto_restore', 15:53:33 INFO - 'tabpaint']}, 15:53:33 INFO - 'other_nol64': {'tests': ['a11yr', 15:53:33 INFO - 'ts_paint', 15:53:33 INFO - 'tpaint', 15:53:33 INFO - 'sessionrestore', 15:53:33 INFO - 'sessionrestore_no_auto_restore', 15:53:33 INFO - 'tabpaint']}, 15:53:33 INFO - 'svgr': {'tests': ['tsvgx', 15:53:33 INFO - 'tsvgr_opacity', 15:53:33 INFO - 'tart', 15:53:33 INFO - 'tscrollx', 15:53:33 INFO - 'cart']}, 15:53:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['tsvgx', 15:53:33 INFO - 'tsvgr_opacity', 15:53:33 INFO - 'tart', 15:53:33 INFO - 'tscrollx', 15:53:33 INFO - 'cart']}, 15:53:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'tests': ['tp5o']}, 15:53:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'talos_options': ['--e10s'], 15:53:33 INFO - 'tests': ['tp5o']}, 15:53:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'talos_options': ['--xperf_path', 15:53:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:33 INFO - 'tests': ['tp5n']}, 15:53:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:33 INFO - 'talos_options': ['--e10s', 15:53:33 INFO - '--xperf_path', 15:53:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:33 INFO - 'tests': ['tp5n']}}, 15:53:33 INFO - 'talos.zip': {'path': '', 15:53:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:33 INFO - Running post-action listener: _resource_record_post_action 15:53:33 INFO - ##### 15:53:33 INFO - ##### Running create-virtualenv step. 15:53:33 INFO - ##### 15:53:33 INFO - Running pre-action listener: _resource_record_pre_action 15:53:33 INFO - Running main action method: create_virtualenv 15:53:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:53:33 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 15:53:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:53:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:34 INFO - Using real prefix '/usr' 15:53:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:53:34 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:36 INFO - Installing pip.................done. 15:53:36 INFO - Return code: 0 15:53:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:53:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:53:36 INFO - Using env: {'DISPLAY': ':0', 15:53:36 INFO - 'HOME': '/home/cltbld', 15:53:36 INFO - 'LANG': 'en_US.UTF-8', 15:53:36 INFO - 'LANGUAGE': 'en_US:en', 15:53:36 INFO - 'LOGNAME': 'cltbld', 15:53:36 INFO - 'MAIL': '/var/mail/cltbld', 15:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:36 INFO - 'MOZ_NO_REMOTE': '1', 15:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:36 INFO - 'NO_EM_RESTART': '1', 15:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:36 INFO - 'SHELL': '/bin/bash', 15:53:36 INFO - 'SHLVL': '1', 15:53:36 INFO - 'TERM': 'linux', 15:53:36 INFO - 'TMOUT': '86400', 15:53:36 INFO - 'USER': 'cltbld', 15:53:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:36 INFO - '_': '/tools/buildbot/bin/python'} 15:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:53:36 INFO - Cleaning up... 15:53:36 INFO - Return code: 0 15:53:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:53:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:53:36 INFO - Using env: {'DISPLAY': ':0', 15:53:36 INFO - 'HOME': '/home/cltbld', 15:53:36 INFO - 'LANG': 'en_US.UTF-8', 15:53:36 INFO - 'LANGUAGE': 'en_US:en', 15:53:36 INFO - 'LOGNAME': 'cltbld', 15:53:36 INFO - 'MAIL': '/var/mail/cltbld', 15:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:36 INFO - 'MOZ_NO_REMOTE': '1', 15:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:36 INFO - 'NO_EM_RESTART': '1', 15:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:36 INFO - 'SHELL': '/bin/bash', 15:53:36 INFO - 'SHLVL': '1', 15:53:36 INFO - 'TERM': 'linux', 15:53:36 INFO - 'TMOUT': '86400', 15:53:36 INFO - 'USER': 'cltbld', 15:53:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:36 INFO - '_': '/tools/buildbot/bin/python'} 15:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:37 INFO - Downloading/unpacking psutil>=0.7.1 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:39 INFO - Installing collected packages: psutil 15:53:39 INFO - Running setup.py install for psutil 15:53:39 INFO - building 'psutil._psutil_linux' extension 15:53:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:53:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:53:39 INFO - building 'psutil._psutil_posix' extension 15:53:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:53:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:53:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:39 INFO - Successfully installed psutil 15:53:39 INFO - Cleaning up... 15:53:39 INFO - Return code: 0 15:53:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:53: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')]} 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:53:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:53:39 INFO - Using env: {'DISPLAY': ':0', 15:53:39 INFO - 'HOME': '/home/cltbld', 15:53:39 INFO - 'LANG': 'en_US.UTF-8', 15:53:39 INFO - 'LANGUAGE': 'en_US:en', 15:53:39 INFO - 'LOGNAME': 'cltbld', 15:53:39 INFO - 'MAIL': '/var/mail/cltbld', 15:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:39 INFO - 'MOZ_NO_REMOTE': '1', 15:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:39 INFO - 'NO_EM_RESTART': '1', 15:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:39 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:39 INFO - 'SHELL': '/bin/bash', 15:53:39 INFO - 'SHLVL': '1', 15:53:39 INFO - 'TERM': 'linux', 15:53:39 INFO - 'TMOUT': '86400', 15:53:39 INFO - 'USER': 'cltbld', 15:53:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:39 INFO - '_': '/tools/buildbot/bin/python'} 15:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:53:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:53:41 INFO - Installing collected packages: mozsystemmonitor 15:53:41 INFO - Running setup.py install for mozsystemmonitor 15:53:41 INFO - Successfully installed mozsystemmonitor 15:53:41 INFO - Cleaning up... 15:53:42 INFO - Return code: 0 15:53:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:53:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:42 INFO - Using env: {'DISPLAY': ':0', 15:53:42 INFO - 'HOME': '/home/cltbld', 15:53:42 INFO - 'LANG': 'en_US.UTF-8', 15:53:42 INFO - 'LANGUAGE': 'en_US:en', 15:53:42 INFO - 'LOGNAME': 'cltbld', 15:53:42 INFO - 'MAIL': '/var/mail/cltbld', 15:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:42 INFO - 'MOZ_NO_REMOTE': '1', 15:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:42 INFO - 'NO_EM_RESTART': '1', 15:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:42 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:42 INFO - 'SHELL': '/bin/bash', 15:53:42 INFO - 'SHLVL': '1', 15:53:42 INFO - 'TERM': 'linux', 15:53:42 INFO - 'TMOUT': '86400', 15:53:42 INFO - 'USER': 'cltbld', 15:53:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:42 INFO - '_': '/tools/buildbot/bin/python'} 15:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:53:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:44 INFO - Downloading docopt-0.6.1.tar.gz 15:53:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:45 INFO - Running setup.py install for blobuploader 15:53:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:53:45 INFO - Running setup.py install for requests 15:53:45 INFO - Running setup.py install for docopt 15:53:45 INFO - Successfully installed blobuploader requests docopt 15:53:45 INFO - Cleaning up... 15:53:45 INFO - Return code: 0 15:53:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:53:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:45 INFO - Using env: {'DISPLAY': ':0', 15:53:45 INFO - 'HOME': '/home/cltbld', 15:53:45 INFO - 'LANG': 'en_US.UTF-8', 15:53:45 INFO - 'LANGUAGE': 'en_US:en', 15:53:45 INFO - 'LOGNAME': 'cltbld', 15:53:45 INFO - 'MAIL': '/var/mail/cltbld', 15:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:45 INFO - 'MOZ_NO_REMOTE': '1', 15:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:45 INFO - 'NO_EM_RESTART': '1', 15:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:45 INFO - 'SHELL': '/bin/bash', 15:53:45 INFO - 'SHLVL': '1', 15:53:45 INFO - 'TERM': 'linux', 15:53:45 INFO - 'TMOUT': '86400', 15:53:45 INFO - 'USER': 'cltbld', 15:53:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:45 INFO - '_': '/tools/buildbot/bin/python'} 15:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:53:45 INFO - Running setup.py (path:/tmp/pip-LYKrYL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:53:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:53:45 INFO - Running setup.py (path:/tmp/pip-5gBetC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:53:46 INFO - Running setup.py (path:/tmp/pip-4e_B3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:53:46 INFO - Running setup.py (path:/tmp/pip-wpXt8I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:53:46 INFO - Running setup.py (path:/tmp/pip-Uq2QMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:53:46 INFO - Running setup.py (path:/tmp/pip-sZ4Scv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:53:46 INFO - Running setup.py (path:/tmp/pip-sGgDaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:53:46 INFO - Running setup.py (path:/tmp/pip-oajDgJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:53:46 INFO - Running setup.py (path:/tmp/pip-6NYG_V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:53:46 INFO - Running setup.py (path:/tmp/pip-izzYk4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:53:46 INFO - Running setup.py (path:/tmp/pip-EdxpDy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:53:46 INFO - Running setup.py (path:/tmp/pip-8bpWgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:53:46 INFO - Running setup.py (path:/tmp/pip-dmm9x5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:53:46 INFO - Running setup.py (path:/tmp/pip-q3wIkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:53:46 INFO - Running setup.py (path:/tmp/pip-oLWR8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:53:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:53:46 INFO - Running setup.py (path:/tmp/pip-KYaZIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:53:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:53:47 INFO - Running setup.py (path:/tmp/pip-3jxhpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:53:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:47 INFO - Running setup.py install for manifestparser 15:53:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Running setup.py install for mozcrash 15:53:47 INFO - Running setup.py install for mozdebug 15:53:47 INFO - Running setup.py install for mozdevice 15:53:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Running setup.py install for mozfile 15:53:47 INFO - Running setup.py install for mozhttpd 15:53:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Running setup.py install for mozinfo 15:53:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Running setup.py install for mozInstall 15:53:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:53:47 INFO - Running setup.py install for mozleak 15:53:48 INFO - Running setup.py install for mozlog 15:53:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:53:48 INFO - Running setup.py install for moznetwork 15:53:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:53:48 INFO - Running setup.py install for mozprocess 15:53:48 INFO - Running setup.py install for mozprofile 15:53:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:53:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:53:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:53:48 INFO - Running setup.py install for mozrunner 15:53:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:53:48 INFO - Running setup.py install for mozscreenshot 15:53:48 INFO - Running setup.py install for moztest 15:53:48 INFO - Running setup.py install for mozversion 15:53:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:53:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:48 INFO - Cleaning up... 15:53:48 INFO - Return code: 0 15:53:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:53: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')]} 15:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:48 INFO - Using env: {'DISPLAY': ':0', 15:53:48 INFO - 'HOME': '/home/cltbld', 15:53:48 INFO - 'LANG': 'en_US.UTF-8', 15:53:48 INFO - 'LANGUAGE': 'en_US:en', 15:53:48 INFO - 'LOGNAME': 'cltbld', 15:53:48 INFO - 'MAIL': '/var/mail/cltbld', 15:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:48 INFO - 'MOZ_NO_REMOTE': '1', 15:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:48 INFO - 'NO_EM_RESTART': '1', 15:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:48 INFO - 'SHELL': '/bin/bash', 15:53:48 INFO - 'SHLVL': '1', 15:53:48 INFO - 'TERM': 'linux', 15:53:48 INFO - 'TMOUT': '86400', 15:53:48 INFO - 'USER': 'cltbld', 15:53:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:48 INFO - '_': '/tools/buildbot/bin/python'} 15:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:53:49 INFO - Running setup.py (path:/tmp/pip-FRdDHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:53:49 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)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:53:49 INFO - Running setup.py (path:/tmp/pip-1JbVlk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:53:49 INFO - Running setup.py (path:/tmp/pip-Nr5lP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:53:49 INFO - Running setup.py (path:/tmp/pip-unnFMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:53:49 INFO - Running setup.py (path:/tmp/pip-EPEKq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:53:49 INFO - Running setup.py (path:/tmp/pip-9CZeEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:53:49 INFO - Running setup.py (path:/tmp/pip-4zwdnB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:53:49 INFO - Running setup.py (path:/tmp/pip-3t6cUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:53:49 INFO - Running setup.py (path:/tmp/pip-s6JP7Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:53:49 INFO - Running setup.py (path:/tmp/pip-sdbx_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:53:49 INFO - Running setup.py (path:/tmp/pip-OK59Qj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:53:49 INFO - Running setup.py (path:/tmp/pip-DYtsBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:53:49 INFO - Running setup.py (path:/tmp/pip-XCAzgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:53:50 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)) 15:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:53:50 INFO - Running setup.py (path:/tmp/pip-JjVJQv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:53:50 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)) 15:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:53:50 INFO - Running setup.py (path:/tmp/pip-pLDgLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:53:50 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)) 15:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:53:50 INFO - Running setup.py (path:/tmp/pip-m0h87u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:53:50 INFO - Running setup.py (path:/tmp/pip-apvpK2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:52 INFO - Downloading blessings-1.6.tar.gz 15:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:52 INFO - Installing collected packages: blessings 15:53:52 INFO - Running setup.py install for blessings 15:53:52 INFO - Successfully installed blessings 15:53:52 INFO - Cleaning up... 15:53:52 INFO - Return code: 0 15:53:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:53:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:53:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:53:52 INFO - Reading from file tmpfile_stdout 15:53:52 INFO - Current package versions: 15:53:52 INFO - argparse == 1.2.1 15:53:52 INFO - blessings == 1.6 15:53:52 INFO - blobuploader == 1.2.4 15:53:52 INFO - docopt == 0.6.1 15:53:52 INFO - manifestparser == 1.1 15:53:52 INFO - mozInstall == 1.12 15:53:52 INFO - mozcrash == 0.17 15:53:52 INFO - mozdebug == 0.1 15:53:52 INFO - mozdevice == 0.48 15:53:52 INFO - mozfile == 1.2 15:53:52 INFO - mozhttpd == 0.7 15:53:52 INFO - mozinfo == 0.9 15:53:52 INFO - mozleak == 0.1 15:53:52 INFO - mozlog == 3.1 15:53:52 INFO - moznetwork == 0.27 15:53:52 INFO - mozprocess == 0.22 15:53:52 INFO - mozprofile == 0.28 15:53:52 INFO - mozrunner == 6.11 15:53:52 INFO - mozscreenshot == 0.1 15:53:52 INFO - mozsystemmonitor == 0.0 15:53:52 INFO - moztest == 0.7 15:53:52 INFO - mozversion == 1.4 15:53:52 INFO - psutil == 3.1.1 15:53:52 INFO - requests == 1.2.3 15:53:52 INFO - wsgiref == 0.1.2 15:53:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:53:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:52 INFO - Using env: {'DISPLAY': ':0', 15:53:52 INFO - 'HOME': '/home/cltbld', 15:53:52 INFO - 'LANG': 'en_US.UTF-8', 15:53:52 INFO - 'LANGUAGE': 'en_US:en', 15:53:52 INFO - 'LOGNAME': 'cltbld', 15:53:52 INFO - 'MAIL': '/var/mail/cltbld', 15:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:52 INFO - 'MOZ_NO_REMOTE': '1', 15:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:52 INFO - 'NO_EM_RESTART': '1', 15:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:52 INFO - 'SHELL': '/bin/bash', 15:53:52 INFO - 'SHLVL': '1', 15:53:52 INFO - 'TERM': 'linux', 15:53:52 INFO - 'TMOUT': '86400', 15:53:52 INFO - 'USER': 'cltbld', 15:53:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:52 INFO - '_': '/tools/buildbot/bin/python'} 15:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:53:52 INFO - Cleaning up... 15:53:52 INFO - Return code: 0 15:53:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:53:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:53:52 INFO - Using env: {'DISPLAY': ':0', 15:53:52 INFO - 'HOME': '/home/cltbld', 15:53:52 INFO - 'LANG': 'en_US.UTF-8', 15:53:52 INFO - 'LANGUAGE': 'en_US:en', 15:53:52 INFO - 'LOGNAME': 'cltbld', 15:53:52 INFO - 'MAIL': '/var/mail/cltbld', 15:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:52 INFO - 'MOZ_NO_REMOTE': '1', 15:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:52 INFO - 'NO_EM_RESTART': '1', 15:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:52 INFO - 'SHELL': '/bin/bash', 15:53:52 INFO - 'SHLVL': '1', 15:53:52 INFO - 'TERM': 'linux', 15:53:52 INFO - 'TMOUT': '86400', 15:53:52 INFO - 'USER': 'cltbld', 15:53:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:52 INFO - '_': '/tools/buildbot/bin/python'} 15:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:53 INFO - Downloading/unpacking jsonschema 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:55 INFO - Downloading/unpacking functools32 (from jsonschema) 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:55 INFO - warning: no files found matching '*.txt' 15:53:55 INFO - no previously-included directories found matching 'build' 15:53:55 INFO - no previously-included directories found matching 'dist' 15:53:55 INFO - no previously-included directories found matching '.git*' 15:53:55 INFO - Installing collected packages: jsonschema, functools32 15:53:55 INFO - Running setup.py install for functools32 15:53:55 INFO - warning: no files found matching '*.txt' 15:53:55 INFO - no previously-included directories found matching 'build' 15:53:55 INFO - no previously-included directories found matching 'dist' 15:53:55 INFO - no previously-included directories found matching '.git*' 15:53:55 INFO - Successfully installed jsonschema functools32 15:53:55 INFO - Cleaning up... 15:53:55 INFO - Return code: 0 15:53:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:53: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')]} 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa26a533f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afe8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, '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': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', '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 15:53:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:53:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:53:55 INFO - Using env: {'DISPLAY': ':0', 15:53:55 INFO - 'HOME': '/home/cltbld', 15:53:55 INFO - 'LANG': 'en_US.UTF-8', 15:53:55 INFO - 'LANGUAGE': 'en_US:en', 15:53:55 INFO - 'LOGNAME': 'cltbld', 15:53:55 INFO - 'MAIL': '/var/mail/cltbld', 15:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:55 INFO - 'MOZ_NO_REMOTE': '1', 15:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:55 INFO - 'NO_EM_RESTART': '1', 15:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:53:55 INFO - 'SHELL': '/bin/bash', 15:53:55 INFO - 'SHLVL': '1', 15:53:55 INFO - 'TERM': 'linux', 15:53:55 INFO - 'TMOUT': '86400', 15:53:55 INFO - 'USER': 'cltbld', 15:53:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:55 INFO - '_': '/tools/buildbot/bin/python'} 15:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:55 INFO - Downloading/unpacking flake8 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:53:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:53:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 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 15:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:53:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:58 INFO - no previously-included directories found matching 'docs/_build' 15:53:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:53:58 INFO - Running setup.py install for pep8 15:53:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:58 INFO - no previously-included directories found matching 'docs/_build' 15:53:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:53:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:53:58 INFO - Cleaning up... 15:53:58 INFO - Return code: 0 15:53:58 INFO - Running post-action listener: _resource_record_post_action 15:53:58 INFO - Running post-action listener: _start_resource_monitoring 15:53:59 INFO - Starting resource monitoring. 15:53:59 INFO - ##### 15:53:59 INFO - ##### Running install step. 15:53:59 INFO - ##### 15:53:59 INFO - Running pre-action listener: _resource_record_pre_action 15:53:59 INFO - Running main action method: install 15:53:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:53:59 INFO - Reading from file tmpfile_stdout 15:53:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:53:59 INFO - Reading from file tmpfile_stdout 15:53:59 INFO - Output received: 15:53:59 INFO - Usage: mozinstall [options] installer 15:53:59 INFO - Options: 15:53:59 INFO - -h, --help show this help message and exit 15:53:59 INFO - -d DEST, --destination=DEST 15:53:59 INFO - Directory to install application into. [default: 15:53:59 INFO - "/builds/slave/test-pgo"] 15:53:59 INFO - --app=APP Application being installed. [default: firefox] 15:53:59 INFO - mkdir: /builds/slave/test-pgo/build/application 15:53:59 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'] 15:53:59 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 15:54:15 INFO - Reading from file tmpfile_stdout 15:54:15 INFO - Output received: 15:54:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:54:15 INFO - Running post-action listener: _resource_record_post_action 15:54:15 INFO - ##### 15:54:15 INFO - ##### Running run-tests step. 15:54:15 INFO - ##### 15:54:15 INFO - Running pre-action listener: _resource_record_pre_action 15:54:15 INFO - Running main action method: run_tests 15:54:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:54:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:54:15 INFO - Python 2.7.3 15:54:15 INFO - Return code: 0 15:54:15 INFO - grabbing minidump binary from tooltool 15:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d8b0>, '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 0x2b8e7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ec60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:54:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:54:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:54:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:15 INFO - Return code: 0 15:54:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:54:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:54:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:54:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:54:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:54:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:54:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:54:16 INFO - Return code: 0 15:54:16 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/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 15:54:16 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/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 15:54:16 INFO - Using env: {'DISPLAY': ':0', 15:54:16 INFO - 'HOME': '/home/cltbld', 15:54:16 INFO - 'LANG': 'en_US.UTF-8', 15:54:16 INFO - 'LANGUAGE': 'en_US:en', 15:54:16 INFO - 'LOGNAME': 'cltbld', 15:54:16 INFO - 'MAIL': '/var/mail/cltbld', 15:54:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:54:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:16 INFO - 'MOZ_NO_REMOTE': '1', 15:54:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:16 INFO - 'NO_EM_RESTART': '1', 15:54:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:54:16 INFO - 'SHELL': '/bin/bash', 15:54:16 INFO - 'SHLVL': '1', 15:54:16 INFO - 'TERM': 'linux', 15:54:16 INFO - 'TMOUT': '86400', 15:54:16 INFO - 'USER': 'cltbld', 15:54:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980', 15:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:16 INFO - '_': '/tools/buildbot/bin/python'} 15:54:16 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/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 15:54:16 INFO - mozversion application_buildid: 20160402133037 15:54:16 INFO - mozversion application_changeset: 873bdc9379fda4887e4a19bfc82998276e1a65d4 15:54:16 INFO - mozversion application_display_name: Nightly 15:54:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:16 INFO - mozversion application_name: Firefox 15:54:16 INFO - mozversion application_remotingname: firefox 15:54:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:54:16 INFO - mozversion application_vendor: Mozilla 15:54:16 INFO - mozversion application_version: 48.0a1 15:54:16 INFO - mozversion platform_buildid: 20160402133037 15:54:16 INFO - mozversion platform_changeset: 873bdc9379fda4887e4a19bfc82998276e1a65d4 15:54:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:54:16 INFO - mozversion platform_version: 48.0a1 15:54:16 INFO - using testdate: 1459637656 15:54:16 INFO - actual date: 1459637656 15:54:16 INFO - starting webserver on 'localhost:51400' 15:54:16 INFO - SUITE-START | Running 2 tests 15:54:16 INFO - TEST-START | dromaeo_css 15:54:16 INFO - operating with platform_type : linux_ 15:54:16 INFO - Initialising browser for dromaeo_css test... 15:54:16 INFO - TEST-INFO | started process 21774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4ivfWe/profile http://localhost:51400/getInfo.html) 15:54:21 INFO - PROCESS | 21774 | __metrics Screen width/height:1600/1200 15:54:21 INFO - PROCESS | 21774 | colorDepth:24 15:54:21 INFO - PROCESS | 21774 | Browser inner width/height: 1024/697 15:54:21 INFO - PROCESS | 21774 | __metrics 15:54:21 ERROR - PROCESS | 21774 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:54:22 INFO - TEST-INFO | 21774: exit 0 15:54:22 INFO - Browser initialized. 15:54:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:22 INFO - TEST-INFO | started process 21854 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4ivfWe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:34 INFO - PROCESS | 21854 | RSS: Main: 153358336 15:54:34 INFO - PROCESS | 21854 | 15:55:25 INFO - PROCESS | 21854 | 1459637725491 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] 15:57:32 INFO - PROCESS | 21854 | Cycle 1(1): loaded http://localhost:51400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51400/tests/dromaeo/cssquery-ext.html) 15:57:33 INFO - PROCESS | 21854 | RSS: Main: 220663808 15:57:33 INFO - PROCESS | 21854 | 16:00:36 INFO - PROCESS | 21854 | Cycle 1(1): loaded http://localhost:51400/tests/dromaeo/cssquery-ext.html (next: http://localhost:51400/tests/dromaeo/cssquery-jquery.html) 16:00:36 INFO - PROCESS | 21854 | RSS: Main: 239427584 16:00:36 INFO - PROCESS | 21854 | 16:03:38 INFO - PROCESS | 21854 | Cycle 1(1): loaded http://localhost:51400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51400/tests/dromaeo/cssquery-mootools.html) 16:03:39 INFO - PROCESS | 21854 | RSS: Main: 243359744 16:03:39 INFO - PROCESS | 21854 | 16:06:41 INFO - PROCESS | 21854 | Cycle 1(1): loaded http://localhost:51400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51400/tests/dromaeo/cssquery-prototype.html) 16:06:41 INFO - PROCESS | 21854 | RSS: Main: 219058176 16:06:41 INFO - PROCESS | 21854 | 16:09:44 INFO - PROCESS | 21854 | Cycle 1(1): loaded http://localhost:51400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51400/tests/dromaeo/cssquery-yui.html) 16:09:44 INFO - PROCESS | 21854 | RSS: Main: 220581888 16:09:44 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | Cycle 1(1): loaded http://localhost:51400/tests/dromaeo/cssquery-yui.html (next: http://localhost:51400/tests/dromaeo/cssquery-dojo.html) 16:12:47 INFO - PROCESS | 21854 | RSS: Main: 254197760 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | __start_tp_report 16:12:47 INFO - PROCESS | 21854 | _x_x_mozilla_page_load 16:12:47 INFO - PROCESS | 21854 | _x_x_mozilla_page_load_details 16:12:47 INFO - PROCESS | 21854 | |i|pagename|runs| 16:12:47 INFO - PROCESS | 21854 | |0;dojo.html;3094.690530946905;3144.7798654094195;3183.570218020568;3185.2833112549665;3216.195951012247;5180.922286165701;5278.049951008817;5294;5310.486086826196;5381.408045115039;5297.788088476456;5307.787688492455;5379.946200537994;5405.783768649249;5424.620276580641;4714.858554243361;4805.543473370033;4862.927056094161;4895.11887860185;4916.975415122919;4863.829765958192;4876.707397556158;4912.7297998610065;4912.9191577853;4970.179920313162;4697.812087516495;4729.976350118227;4819.397575303087;4829.565339119478;4835.1296766582;4797.496262892381;4805.231163013936;4806.7836947337455;4855.028994201139;4863.659543831933;4771.045790841811;4771.6182705383835;4797.64017698674;4802.807887684523;4845.3216549683075;5147.176451767699;5152.562032227228;5251.921221181686;5268.6575372600655;5293.153095504701;5615.2700148980775;5661.971690141523;5662.462066103755;5663.5186009189265;5672.092465205588;5684.658920464785;5687.232223649837;5687.26065611472;5700.857478563069;5708.543316534668;5198.298229738974;5293.417724050351;5331.493508116722;5395.838124856221;5407.70257635826;5739.196512488255;5756.3380211276235;5756.798512052058;5759.798407055733;5815.244018277597;5383.515483606494;5506.201600767866;5513.145462453326;5516.255305533701;5516.889662206733;5539.446055394428;5644.774209031675;5663.178839068394;5664.6601203927075;5665.745041473061;5624.634398764068;5640.633358831663;5643.040683083886;5647.463490968352;5648.378678345379;5577.525910297589;5599.048161812501;5653.491185793298;5655.179998900218;5656.632318899258;4183;4228.9154216915485;4272.829086836554;4277.679174061957;4292.978535107304;3812.3519001769764;3828.1769419574925;3841.4814000110186;3864;3865.014421322545;5215.921761173586;5314.0700377433795;5319.734013299397;5325.733713314319;5375.596830237748;5599.944000559943;5668.943310566924;5679.233303503974;5706.885862282731;5716.942830571724;5274.393444753902;5274.630775845654;5284.973575132177;5293.708846013506;5304.257403963448;4640.721556706609;4684.063187362473;4684.063187362541;4694.976525117352;4733.763311834395;5826.359100498942;5839.854003649943;5846.356900740915;5856.297244330707;5905.793297234576;5640.125780504029;5651.406602306699;5656.208130861765;5656.2929633795775;5656.406077361982;5714.514266287412;5744.080947048452;5796.884062318814;5826.475617194473;5828.679422631626;5554.75003624846;5556.611037227517;5572.052751032254;5601.29983752031;5612.8877422450505;5686.488216060575;5694.231278777312;5718.599698021098;5719.8570035749435;5720.856978575569;5419.105847535113;5520.779168833202;5545.528630066328;5635.9436405635415;5648.604597678123;5534.833954981357;5541.639793413416;5546.916796248141;5548.250986116823;5549.056660367828;5430.484104010113;5470.316210473691;5475.589330800286;5486.039943009878;5530.6128570999645;5318.441563635763;5452.2094296327605;5457.754401052041;5541.33503979525;5581.916271255853;5354.651947623392;5480.232767412645;5491.670499770026;5492.835214943558;5554.944450555605 16:12:47 INFO - PROCESS | 21854 | |1;ext.html;557.9135234038725;562.5190462154858;576.4293349583911;578.9044807606745;633.8700566383892;30271.394572108544;41723;42495.78752106239;42599.509017184406;42616.78691606545;45404.318935216;45437.318440223426;45935.31097033539;46012.769936150355;46071.308930366074;8705.303575713944;8898.86651700225;8907.554622268894;8917.643294268222;8995.41529800564;8680.435771674853;8824.117588241188;8835.911640883573;8844.513551754651;8845.380823342368;8821.51481668508;8844.380893337437;8915.153060459246;8917.286617070618;8923.464592124494;8816.206541411271;8845.203931646183;8855.512946787892;8899.02110767815;8909.420887642314;8836.779080522974;8876.911230887674;8967.282617390592;8981.371304008722;8985.955070224672;41594.1681166375;41917.580824191675;41936;41979.7901010493;42021.36967945483;3666.4866918631415;3703.518542589473;3778.131029863147;3819.2361527694293;4304.956950430487;31069.533956990665;31383.843080784678;32161.678383216335;32230.838845805854;32237.838810805795;4143.544210136883;4147.151875158326;4222.78886055696;4264.147170565868;4367.58507941745;330869;331301;331677;331944;332157;53981.46018539764;57607.711961440764;58935;58946.11580826291;65449.67275163689;61527;61711.07433388503;61738;61866;61930;16089.919550402174;16228.837711622733;16238.188090595422;16274.349026039063;16588.917055414644;11554.248973816675;12812.61562153137;12846;12896.48414063427;12961.481540738265;18805.435836924913;19099.90450047741;19186.232550698096;19669.22976932083;19857.702134467996;7185.640717964081;7459.254074592606;7478.663460144307;7511.0610130945;7548.4716069874585;1011.8026984737905;1027.5222021759917;1083.788661211072;1107.5625128074525;1192.1714408486018;30787.538186927213;30959.535606965914;31168.376632467676;31208;31489.527657085164;1082.8429877667852;1145.1869172887177;1161.2916121166081;1207.2877002568528;1224.6448529926222;15412.691746165014;15682.529524114294;15851.024208566108;16119.435819746253;16307.021578705315;362392;369275;371774;375319;391648;52879.735601322514;53051;53543.19685204647;53684.73157634265;53854;1387.6322774464775;1389.3539504130426;1389.4442223110836;1402.8737413632823;1410.4287763455611;29020.709792901802;29298.707012930452;29563.85218073896;29598.704012959595;30031;45057.774711126236;45096.323555147355;45419.09161816811;45456.772716136205;45515.54484455113;295525;309911;311083;312347;312443;47014.76492617515;47733.76133119312;47816.282755757995;48355.758221210075;48545.5145448541;45603.77198113988;45797.31304030509;45882.54117458916;47120.7643961778;47273.763631181624;38933.22133557256;40367.3944890821;40509.797451013736;40583.39124913188;40741.38887916743;39344.21311573695;40434.39348409717;40797.1840563193;41577;41919.58080419279;39718.60281397149;40283;40965;41152.1769564613;41586.168276634904;34473.310533789685;36922.8153859229;37473.62526374702;38115.61884381121;38128.37780410857;28696.426071478036;29384.412311753218;29900.70099298979;29901.850490747405;29946.25134371658 16:12:47 INFO - PROCESS | 21854 | |2;jquery.html;343.0531732418524;346.31602584894836;348.2304107921493;350.36583783352137;353.8089431706878;17137.82862171378;17698.292068317267;18056.09719514024;18762.906185469055;18764.71852922207;18068;18184.54538636535;18449.169787359566;18461.815381846176;18464.907675461636;4539.364488971547;5708.8858222835515;5716.056850619642;5720.8283751487525;5721.141828725683;5598.188262701906;5644.887102257952;5665.036943719578;5668.68822214778;5674.177244299574;5378.220158077076;5600.327960644708;5609.52319052881;5609.719514024303;5611.466910643503;5482.150266708666;5531.3362396512275;5534.778608855661;5537.418571050042;5539.086050801613;4847.030593881203;4997.825076122354;5075.898482030376;5076.035553244908;5077.695338279715;13094.934525327313;13111.475540978445;16036.037837729773;21128.788712112837;21149.5770084599;2051.507638166844;2175.7715439878903;2260.9660855087186;2583.225032490245;2861.78536609753;9172.6789562365;9243.584038718274;9379.155875971195;9432.103950124727;9629.470379129145;1923.923043078289;1924.2976313645418;2001.9099140538565;2013.2953466286829;2021.989890050555;54089.45910540884;66094;68876.6556167221;69072.65463672699;70546.64726676384;9464.47945362998;10026.19790416765;10281.53733082013;10381.896181038244;10382.948085259526;12148.299238106672;14132.858671413154;14223.075500092667;14224.786628200585;14229.64425889361;9413.90586094144;9440.716778496657;9656.37233579815;9702.369345992487;10036.046575575308;7904.683812647545;8067.556284404414;8132.75601731949;8184.836303273901;8337.207965243293;7692.653830577638;8017.318527925192;8063.6774529018185;8180.181981801772;8186.263236308641;3017.5926249956415;3076.661567227603;3099;3133.8433078345993;3179.7456203504125;869.1959937058323;893.4639216470066;990.1830989433602;994.572333896417;1068.0921216965517;16752.329906803836;17402.65194696099;17686.569013805187;17742.556436088944;18040.368587099387;952.1002652493328;973.493783232715;1044.1385856668278;1064.4305296666246;1087.4127970895627;9663.178629816544;9789.461579613047;10061;10183.287169898183;10241.283110182216;451827;464710;473104;473716;479849;81377.59311203405;81447;81918.18081819106;82089;82107;1066.1151244467228;1076.0261962923723;1104.629948967105;1116.4696769034645;1125.0605744203517;15840.207989600704;15878.206089695237;16036.679266414372;16179.919100404422;16435.178241088135;27985.580216297178;36070.21262767372;36352.63647363493;36416;36786.63213367832;51445.22832157595;52132.73933630308;53031.469685302654;53057.73471132619;53171.46828531665;8025.2777250047775;8038.598070096588;8071.313938315309;8309.626066827128;8440.240378365976;8991.28069754405;11825.526978920747;12177.634670959886;12295.446704898122;12315.261084334968;10979.945100274448;11007.504662290055;11055.115590752559;11119;11199.440027998731;5836.737346819318;7567.978322926555;10979.505922233358;11144.888551114385;11411.543538258376;11364.772704545698;11637.476313565741;11711.531538738354;11750.412479375826;11766.88233117658;7841.607919603883;8043.316318113026;8188.426810123472;8209.070868346053;8326.70856520019;10293;11295.3787541686;11355.37545435009;11515.19393642437;11579.8263026053 16:12:47 INFO - PROCESS | 21854 | |3;mootools.html;1315.5066849931275;1337.7792664210406;1361.3125371687297;1441.9783703244452;1673.7740405045322;7464.402847772179;7715.729949451763;7738.883916741253;7769.650365733542;7774.766756997285;7491.587962662052;7519;7591.468597198198;7597.050368703912;7597.164311925698;1924.4996300961711;2141.764405915348;2152.698622192894;2168.7072245246845;2192.6162921488753;2158.2985529702833;2160.1899287767087;2164.7943445372666;2164.9025793839314;2165.28545579959;2072.2643461571074;2171.6742488626755;2172.228858755143;2175.6083904897114;2178.18318130701;2132.562824620949;2168.5879682860286;2168.913243470259;2178.6514157734846;2192.1341070277313;2070.5858828234414;2076.719642848211;2081.7293751812317;2081.885496297703;2093.3510611710267;7742.651580678883;7775.183605721431;7786.416018798613;7795.298423141944;7810.453268271223;4751.073540659573;4869.196582563873;4875.853724388274;4879.194932836078;4881.096997055521;3060.3114299282706;3092.072378286505;3125.9531107033413;3131.874725010997;3160.288934989632;965.1940629574314;968.5351031504847;980.294188184506;995.3132338686283;1018.7453136715822;11003.33979961205;11086.61196858114;11096.33421994683;11099.44502774858;11106.833397499044;3995.2808494471274;4144.937825932613;4158.293090174678;4173.1862286853775;4191.036061705764;9357.812843743088;9462.716118516455;9468.14786669203;9482.19401350893;9484.668036618823;4384.47386313638;4792.0895029944195;4808.230683090689;4824.831130910401;4829.420469543677;4299.398084268205;4308.590683885026;4352.064306174188;4363.127374525107;4363.258246098171;3408.0968543336035;3465.8267086645565;3487.459443786217;3525.7355698322726;3543.7165026797793;1075.9731006724737;1085.403028334413;1088.7169335972703;1089.536946797608;1101.031092638489;1381.6614929342174;1384.4254634326642;1409.4080486195821;1439.1365180891382;1439.7768345906402;7641.312281894545;7822.6088695564995;7829.921700783033;7834.725784597512;7836.882446763303;1135.5968631135993;1142.5258517715222;1171.3264872698232;1172.6657902497918;1183.0594677231622;5995.940040599538;6079.513638908877;6094.238220222473;6112.51099912006;6119.877602447926;9287.349885508085;9674.322797404115;9683.709488715349;9699.660511882192;9816.361936474106;9592.232621390272;9660.082292182231;9666.854997175047;9672.129508344142;9689.806203876024;7226.891596626055;7423.183449820515;7451.329380355685;7486.513376630611;7540.585267810323;7340.1191856975365;7382.6677799498075;7452.515586486861;7468.141163766019;7474.476786624884;8402.277533105576;8629.568521574021;8737.56312184401;8848;8881.955590222007;8487.151284871463;8667.82664346697;8802.33982451306;8809.471431714117;8811.735647930573;6408;6707;6862.4853136014;6912.205096413977;7023.086998690342;7500.1374841893885;7518.924810751822;7534.095908491016;7545.396368290414;7562.432817538596;6491.545591808528;6580.243272023587;6646.60120392778;6683.264840867403;6762.52662313653;6383.329750376143;6391.392817682313;6628.966855165886;6688.264290928091;6707.429868461236;7197.8587194261945;7216.097987751531;7336.96331518339;7341.375983041501;7341.632918353954;6685.933140668531;6758.662066896733;6768.08630834831;6772.322767723188;6772.93227067723;6886.208086070166;6900.309969003059;6909.7581584644295;6912.274211207952;6923.030775691306 16:12:47 INFO - PROCESS | 21854 | |4;prototype.html;311.8581045624241;314.859887350129;318.09977762930896;321.5835493036518;322.17201791396104;5805.274340707411;5954.136650185726;5993.520518358532;6018.488428483584;6102.237220347457;5843.18195452637;5904.881902361961;5927.911081333784;5928.081147422156;5940.821775346746;4299.591538803808;4366.279563871957;4438.312061630436;4478.171538265415;4479.641628669707;4465.5311192324825;4473.261911784552;4474.217012022899;4481.193385190664;4484.618807401374;4417.602415782579;4427.778611069433;4428.3800267962515;4428.889277768066;4442.11157768446;4265.488141423018;4320.546342634009;4346.521882592912;4405.31717583775;4435.844745433894;3792.924141517154;3804.201117765245;3807.5240594925635;3810.0093975566274;3810.6760925321105;5531.640443371209;5564.4991950724225;5618.185363122325;5647.491725744702;5648.661080335193;5060.114479965991;5086.949130508685;5088.313077734496;5088.6946783193125;5099.643024988252;6127.448529632355;6141.109539116803;6153.661548614825;6155.138280640714;6167.907481387782;4135.77253251071;4228.429162063113;4230.51349094855;4242.915141697149;4243.702940794145;6405.583637063576;6426.164598602199;6463.353664633546;6473.126127972758;6473.773417930397;4280.357946308079;4280.4863416390235;4282.614564689131;4286.37847512109;4289.785510724514;4325.589069038437;4327.459067616548;4332.610065094157;4333.739975601474;4337.60961513459;5073;5075;5076.923846142311;5077.26379674945;5078.263651770472;6247.375262473807;6248.50011999039;6248.875022499525;6250.062490626351;6259.6870156492905;1486.4648726458465;1499.8050253467197;1529.1207555655542;1529.7475916473657;1533.110795738469;928.0255731481917;937.315759495572;945.2910317262053;952.1620973543238;991.5538007896475;5901.527877769769;6020.819375418744;6023.247094113236;6030.517558595302;6031.215941927521;6407.615543067431;6463.515236357198;6464.22429308486;6466.708998095097;6471.449926756184;5992.550558708114;5992.820215393545;5997.1304160896425;5998.4601385875485;6000.069989151689;3429.2798512312197;3457.1702791330404;3474.2877710069374;3474.8262586870555;3475.669811367916;6488.837779055561;6672.499562532732;6687.598744075371;6704.061431399608;6724.7646332378135;6611.173603299588;6615.735370585219;6630.071789949411;6631.403173714389;6634.966825165843;6671.199456065303;6673.9666301668185;6680.0981867448245;6687.6321802301345;6688.832779180462;6435.292117867125;6473.676316184266;6480.935190648033;6481.287058423475;6487.610743355413;6237.781677641261;6395.5203359747275;6399.584027038228;6402.199725034371;6441.871162576628;6644.10304608891;6656.633885136364;6679.56582822115;6684.0642310075655;6697.732090716511;4234.555371685929;4264.232438161161;4272.145570885773;4274.700770946004;4279.358096285582;6454.838629034311;6455.580387274812;6480.351964803482;6534.183227096613;6534.640594767143;6233.688315584293;6287.371262873676;6298.84252893663;6304.495640348853;6309.1167236586;6116.877662446637;6199.194104766351;6221.2845522763655;6239.06414037898;6249.7187626557825;6096.055111457731;6120.357362476876;6131.63210207389;6134;6157.322694503511;6292;6293.905591416041;6294;6294.118823364641;6372.87254254903;5880.911786323294;5967.8209653710455;6138.846528836815;6143.96928015357;6146.508279337731 16:12:47 INFO - PROCESS | 21854 | |5;yui.html;720.4812534974819;738.7451329291392;781.945263831532;810.3800592546702;839.9878146833065;13845.307734613267;14114;14121.505747298846;14166.36251368687;16714.164291785422;14553.927230363834;14644.487442939499;14663;14807.555773326818;14849.480268190615;646.1277275677844;724.065954918155;741.7033186725326;757.178461369412;766.1840140250644;738.656524716007;750.1897950213784;754.2193829386586;759.8708219602653;764.4610549562545;774.0517865614634;778.5212094561832;794.7575989323254;799.8760192170223;802.1096582793095;686.2828344380134;762.5920132728991;807.0799288810761;807.9353651707908;810.5420437452821;564.6668465605271;569.6752850875002;573.020135568179;575.5280669850724;583.9211706419621;13655.453781848713;13779.862201378059;13820.585382438543;13858.930705346409;13957;12753.61739147827;13239.86760132396;13338.799918001238;13393.397297121654;13471;10003.24975626831;10019.398836069786;10277.075063244343;10336.586536538529;10348.741281467948;3643.744937854351;3682.760620559655;3757.755745876509;3790.3935370340887;3817.522809648794;55055.44944550543;55452.44547554554;55477.722611387086;55777.72111139418;55788;10134.341267817568;10670.35977841332;10678.305910115818;10863.348199108079;11093.168012399103;18117.818821811878;18138.727919081226;18159.546011349823;18246.270149194148;18285.90857045733;8419.579021048923;8468.026176989602;8576.957115214509;8714.782130446789;8751.037385887546;4833.492483289204;4877.68295060827;4972.825951091694;4982.177940639826;4994.825181118644;3218.935621287561;3237.5143728440453;3240.902772916816;3260.951085733716;3277.721393681516;586.2964442668814;603.728322254987;607.0833042106451;610.703808652803;612.2958597612692;655.4887187993373;742.8105833012547;750.7372419653187;763.2253262938123;783.1815752538497;8711.738647840575;8782.780430489289;8889.955550222208;8997.595108220146;9147.753703023625;639.5682914033102;698.7305242455595;711.2283172757616;758.040465396955;780.2314720000795;4094.651954583834;4154.667626589866;4180.184863951561;4182.769947652909;4265.978670106691;67180.32819671741;67393;67597.66201169061;67676.66161669258;67977.66011170011;55086.62283442946;58987;59460.40539594635;59496;59601.40398596045;49953.50046499561;51061.23408148881;51066;51667.74166129145;51964;8235;8310.418270720991;8317.542535160383;8491.19333663301;8573.356998225034;39725.602743973344;40154.1969160621;40623.796881015405;40963.38554921619;41196.79401602973;43649.34525982049;46220.30669540027;46392;52383;52430.73784631053;11789.351585662871;11812.527498899948;11824.645260642195;12010.459529321026;12286.078544109048;13209.933950330187;13574.59276221715;13636.318204080128;13694.589162325146;13898.791518127035;12369.752604948031;12513.499460021498;12730.23618582888;13265.336733163496;13554.86445135536;12756.234625922474;12943.09398342107;13072.346382680638;13271.336433178109;13509.121907076009;12136.696582585506;12318.322492263012;12359.814602781145;12461.501539938663;12714.87285127137;10329.74175645615;10632.734181645212;10674;11001.669949901196;11146.331220126818;10626.8405973912;10662.46687665598;10845.783084338427;10881.075108615856;11003.834942475709 16:12:47 INFO - PROCESS | 21854 | __end_tp_report 16:12:47 INFO - PROCESS | 21854 | __start_cc_report 16:12:47 INFO - PROCESS | 21854 | _x_x_mozilla_cycle_collect,928 16:12:47 INFO - PROCESS | 21854 | __end_cc_report 16:12:47 INFO - PROCESS | 21854 | __startTimestamp1459638767357__endTimestamp 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | ------- Summary: start ------- 16:12:47 INFO - PROCESS | 21854 | Number of tests: 6 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | [#0] dojo.html Cycles:165 Average:5247.69 Median:5470.32 stddev:589.40 (10.8%) stddev-sans-first:566.49 16:12:47 INFO - PROCESS | 21854 | Values: 3094.7 3144.8 3183.6 3185.3 3216.2 5180.9 5278.0 5294.0 5310.5 5381.4 5297.8 5307.8 5379.9 5405.8 5424.6 4714.9 4805.5 4862.9 4895.1 4917.0 4863.8 4876.7 4912.7 4912.9 4970.2 4697.8 4730.0 4819.4 4829.6 4835.1 4797.5 4805.2 4806.8 4855.0 4863.7 4771.0 4771.6 4797.6 4802.8 4845.3 5147.2 5152.6 5251.9 5268.7 5293.2 5615.3 5662.0 5662.5 5663.5 5672.1 5684.7 5687.2 5687.3 5700.9 5708.5 5198.3 5293.4 5331.5 5395.8 5407.7 5739.2 5756.3 5756.8 5759.8 5815.2 5383.5 5506.2 5513.1 5516.3 5516.9 5539.4 5644.8 5663.2 5664.7 5665.7 5624.6 5640.6 5643.0 5647.5 5648.4 5577.5 5599.0 5653.5 5655.2 5656.6 4183.0 4228.9 4272.8 4277.7 4293.0 3812.4 3828.2 3841.5 3864.0 3865.0 5215.9 5314.1 5319.7 5325.7 5375.6 5599.9 5668.9 5679.2 5706.9 5716.9 5274.4 5274.6 5285.0 5293.7 5304.3 4640.7 4684.1 4684.1 4695.0 4733.8 5826.4 5839.9 5846.4 5856.3 5905.8 5640.1 5651.4 5656.2 5656.3 5656.4 5714.5 5744.1 5796.9 5826.5 5828.7 5554.8 5556.6 5572.1 5601.3 5612.9 5686.5 5694.2 5718.6 5719.9 5720.9 5419.1 5520.8 5545.5 5635.9 5648.6 5534.8 5541.6 5546.9 5548.3 5549.1 5430.5 5470.3 5475.6 5486.0 5530.6 5318.4 5452.2 5457.8 5541.3 5581.9 5354.7 5480.2 5491.7 5492.8 5554.9 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | [#1] ext.html Cycles:180 Average:51784.49 Median:41058.59 stddev:88786.79 (216.2%) stddev-sans-first:88952.55 16:12:47 INFO - PROCESS | 21854 | Values: 557.9 562.5 576.4 578.9 633.9 30271.4 41723.0 42495.8 42599.5 42616.8 45404.3 45437.3 45935.3 46012.8 46071.3 8705.3 8898.9 8907.6 8917.6 8995.4 8680.4 8824.1 8835.9 8844.5 8845.4 8821.5 8844.4 8915.2 8917.3 8923.5 8816.2 8845.2 8855.5 8899.0 8909.4 8836.8 8876.9 8967.3 8981.4 8986.0 41594.2 41917.6 41936.0 41979.8 42021.4 3666.5 3703.5 3778.1 3819.2 4305.0 31069.5 31383.8 32161.7 32230.8 32237.8 4143.5 4147.2 4222.8 4264.1 4367.6 330869.0 331301.0 331677.0 331944.0 332157.0 53981.5 57607.7 58935.0 58946.1 65449.7 61527.0 61711.1 61738.0 61866.0 61930.0 16089.9 16228.8 16238.2 16274.3 16588.9 11554.2 12812.6 12846.0 12896.5 12961.5 18805.4 19099.9 19186.2 19669.2 19857.7 7185.6 7459.3 7478.7 7511.1 7548.5 1011.8 1027.5 1083.8 1107.6 1192.2 30787.5 30959.5 31168.4 31208.0 31489.5 1082.8 1145.2 1161.3 1207.3 1224.6 15412.7 15682.5 15851.0 16119.4 16307.0 362392.0 369275.0 371774.0 375319.0 391648.0 52879.7 53051.0 53543.2 53684.7 53854.0 1387.6 1389.4 1389.4 1402.9 1410.4 29020.7 29298.7 29563.9 29598.7 30031.0 45057.8 45096.3 45419.1 45456.8 45515.5 295525.0 309911.0 311083.0 312347.0 312443.0 47014.8 47733.8 47816.3 48355.8 48545.5 45603.8 45797.3 45882.5 47120.8 47273.8 38933.2 40367.4 40509.8 40583.4 40741.4 39344.2 40434.4 40797.2 41577.0 41919.6 39718.6 40283.0 40965.0 41152.2 41586.2 34473.3 36922.8 37473.6 38115.6 38128.4 28696.4 29384.4 29900.7 29901.9 29946.3 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | [#2] jquery.html Cycles:180 Average:26908.19 Median:36211.42 stddev:76922.01 (212.4%) stddev-sans-first:77111.93 16:12:47 INFO - PROCESS | 21854 | Values: 343.1 346.3 348.2 350.4 353.8 17137.8 17698.3 18056.1 18762.9 18764.7 18068.0 18184.5 18449.2 18461.8 18464.9 4539.4 5708.9 5716.1 5720.8 5721.1 5598.2 5644.9 5665.0 5668.7 5674.2 5378.2 5600.3 5609.5 5609.7 5611.5 5482.2 5531.3 5534.8 5537.4 5539.1 4847.0 4997.8 5075.9 5076.0 5077.7 13094.9 13111.5 16036.0 21128.8 21149.6 2051.5 2175.8 2261.0 2583.2 2861.8 9172.7 9243.6 9379.2 9432.1 9629.5 1923.9 1924.3 2001.9 2013.3 2022.0 54089.5 66094.0 68876.7 69072.7 70546.6 9464.5 10026.2 10281.5 10381.9 10382.9 12148.3 14132.9 14223.1 14224.8 14229.6 9413.9 9440.7 9656.4 9702.4 10036.0 7904.7 8067.6 8132.8 8184.8 8337.2 7692.7 8017.3 8063.7 8180.2 8186.3 3017.6 3076.7 3099.0 3133.8 3179.7 869.2 893.5 990.2 994.6 1068.1 16752.3 17402.7 17686.6 17742.6 18040.4 952.1 973.5 1044.1 1064.4 1087.4 9663.2 9789.5 10061.0 10183.3 10241.3 451827.0 464710.0 473104.0 473716.0 479849.0 81377.6 81447.0 81918.2 82089.0 82107.0 1066.1 1076.0 1104.6 1116.5 1125.1 15840.2 15878.2 16036.7 16179.9 16435.2 27985.6 36070.2 36352.6 36416.0 36786.6 51445.2 52132.7 53031.5 53057.7 53171.5 8025.3 8038.6 8071.3 8309.6 8440.2 8991.3 11825.5 12177.6 12295.4 12315.3 10979.9 11007.5 11055.1 11119.0 11199.4 5836.7 7568.0 10979.5 11144.9 11411.5 11364.8 11637.5 11711.5 11750.4 11766.9 7841.6 8043.3 8188.4 8209.1 8326.7 10293.0 11295.4 11355.4 11515.2 11579.8 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | [#3] mootools.html Cycles:180 Average:5523.48 Median:6604.61 stddev:2926.68 (44.3%) stddev-sans-first:2917.80 16:12:47 INFO - PROCESS | 21854 | Values: 1315.5 1337.8 1361.3 1442.0 1673.8 7464.4 7715.7 7738.9 7769.7 7774.8 7491.6 7519.0 7591.5 7597.1 7597.2 1924.5 2141.8 2152.7 2168.7 2192.6 2158.3 2160.2 2164.8 2164.9 2165.3 2072.3 2171.7 2172.2 2175.6 2178.2 2132.6 2168.6 2168.9 2178.7 2192.1 2070.6 2076.7 2081.7 2081.9 2093.4 7742.7 7775.2 7786.4 7795.3 7810.5 4751.1 4869.2 4875.9 4879.2 4881.1 3060.3 3092.1 3126.0 3131.9 3160.3 965.2 968.5 980.3 995.3 1018.7 11003.3 11086.6 11096.3 11099.4 11106.8 3995.3 4144.9 4158.3 4173.2 4191.0 9357.8 9462.7 9468.1 9482.2 9484.7 4384.5 4792.1 4808.2 4824.8 4829.4 4299.4 4308.6 4352.1 4363.1 4363.3 3408.1 3465.8 3487.5 3525.7 3543.7 1076.0 1085.4 1088.7 1089.5 1101.0 1381.7 1384.4 1409.4 1439.1 1439.8 7641.3 7822.6 7829.9 7834.7 7836.9 1135.6 1142.5 1171.3 1172.7 1183.1 5995.9 6079.5 6094.2 6112.5 6119.9 9287.3 9674.3 9683.7 9699.7 9816.4 9592.2 9660.1 9666.9 9672.1 9689.8 7226.9 7423.2 7451.3 7486.5 7540.6 7340.1 7382.7 7452.5 7468.1 7474.5 8402.3 8629.6 8737.6 8848.0 8882.0 8487.2 8667.8 8802.3 8809.5 8811.7 6408.0 6707.0 6862.5 6912.2 7023.1 7500.1 7518.9 7534.1 7545.4 7562.4 6491.5 6580.2 6646.6 6683.3 6762.5 6383.3 6391.4 6629.0 6688.3 6707.4 7197.9 7216.1 7337.0 7341.4 7341.6 6685.9 6758.7 6768.1 6772.3 6772.9 6886.2 6900.3 6909.8 6912.3 6923.0 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | [#4] prototype.html Cycles:180 Average:5186.78 Median:6009.28 stddev:1605.45 (26.7%) stddev-sans-first:1567.70 16:12:47 INFO - PROCESS | 21854 | Values: 311.9 314.9 318.1 321.6 322.2 5805.3 5954.1 5993.5 6018.5 6102.2 5843.2 5904.9 5927.9 5928.1 5940.8 4299.6 4366.3 4438.3 4478.2 4479.6 4465.5 4473.3 4474.2 4481.2 4484.6 4417.6 4427.8 4428.4 4428.9 4442.1 4265.5 4320.5 4346.5 4405.3 4435.8 3792.9 3804.2 3807.5 3810.0 3810.7 5531.6 5564.5 5618.2 5647.5 5648.7 5060.1 5086.9 5088.3 5088.7 5099.6 6127.4 6141.1 6153.7 6155.1 6167.9 4135.8 4228.4 4230.5 4242.9 4243.7 6405.6 6426.2 6463.4 6473.1 6473.8 4280.4 4280.5 4282.6 4286.4 4289.8 4325.6 4327.5 4332.6 4333.7 4337.6 5073.0 5075.0 5076.9 5077.3 5078.3 6247.4 6248.5 6248.9 6250.1 6259.7 1486.5 1499.8 1529.1 1529.7 1533.1 928.0 937.3 945.3 952.2 991.6 5901.5 6020.8 6023.2 6030.5 6031.2 6407.6 6463.5 6464.2 6466.7 6471.4 5992.6 5992.8 5997.1 5998.5 6000.1 3429.3 3457.2 3474.3 3474.8 3475.7 6488.8 6672.5 6687.6 6704.1 6724.8 6611.2 6615.7 6630.1 6631.4 6635.0 6671.2 6674.0 6680.1 6687.6 6688.8 6435.3 6473.7 6480.9 6481.3 6487.6 6237.8 6395.5 6399.6 6402.2 6441.9 6644.1 6656.6 6679.6 6684.1 6697.7 4234.6 4264.2 4272.1 4274.7 4279.4 6454.8 6455.6 6480.4 6534.2 6534.6 6233.7 6287.4 6298.8 6304.5 6309.1 6116.9 6199.2 6221.3 6239.1 6249.7 6096.1 6120.4 6131.6 6134.0 6157.3 6292.0 6293.9 6294.0 6294.1 6372.9 5880.9 5967.8 6138.8 6144.0 6146.5 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - PROCESS | 21854 | [#5] yui.html Cycles:180 Average:15301.35 Median:44934.83 stddev:18258.80 (40.6%) stddev-sans-first:18277.18 16:12:47 INFO - PROCESS | 21854 | Values: 720.5 738.7 781.9 810.4 840.0 13845.3 14114.0 14121.5 14166.4 16714.2 14553.9 14644.5 14663.0 14807.6 14849.5 646.1 724.1 741.7 757.2 766.2 738.7 750.2 754.2 759.9 764.5 774.1 778.5 794.8 799.9 802.1 686.3 762.6 807.1 807.9 810.5 564.7 569.7 573.0 575.5 583.9 13655.5 13779.9 13820.6 13858.9 13957.0 12753.6 13239.9 13338.8 13393.4 13471.0 10003.2 10019.4 10277.1 10336.6 10348.7 3643.7 3682.8 3757.8 3790.4 3817.5 55055.4 55452.4 55477.7 55777.7 55788.0 10134.3 10670.4 10678.3 10863.3 11093.2 18117.8 18138.7 18159.5 18246.3 18285.9 8419.6 8468.0 8577.0 8714.8 8751.0 4833.5 4877.7 4972.8 4982.2 4994.8 3218.9 3237.5 3240.9 3261.0 3277.7 586.3 603.7 607.1 610.7 612.3 655.5 742.8 750.7 763.2 783.2 8711.7 8782.8 8890.0 8997.6 9147.8 639.6 698.7 711.2 758.0 780.2 4094.7 4154.7 4180.2 4182.8 4266.0 67180.3 67393.0 67597.7 67676.7 67977.7 55086.6 58987.0 59460.4 59496.0 59601.4 49953.5 51061.2 51066.0 51667.7 51964.0 8235.0 8310.4 8317.5 8491.2 8573.4 39725.6 40154.2 40623.8 40963.4 41196.8 43649.3 46220.3 46392.0 52383.0 52430.7 11789.4 11812.5 11824.6 12010.5 12286.1 13209.9 13574.6 13636.3 13694.6 13898.8 12369.8 12513.5 12730.2 13265.3 13554.9 12756.2 12943.1 13072.3 13271.3 13509.1 12136.7 12318.3 12359.8 12461.5 12714.9 10329.7 10632.7 10674.0 11001.7 11146.3 10626.8 10662.5 10845.8 10881.1 11003.8 16:12:47 INFO - PROCESS | 21854 | -------- Summary: end -------- 16:12:47 INFO - PROCESS | 21854 | 16:12:47 INFO - TEST-INFO | 21854: exit 0 16:12:47 INFO - TEST-OK | dromaeo_css | took 1111027ms 16:12:47 INFO - TEST-START | kraken 16:12:47 INFO - operating with platform_type : linux_ 16:12:47 INFO - Initialising browser for kraken test... 16:12:47 INFO - TEST-INFO | started process 22038 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpklVQx4/profile http://localhost:51400/getInfo.html) 16:12:51 INFO - PROCESS | 22038 | __metrics Screen width/height:1600/1200 16:12:51 INFO - PROCESS | 22038 | colorDepth:24 16:12:51 INFO - PROCESS | 22038 | Browser inner width/height: 1024/697 16:12:51 INFO - PROCESS | 22038 | __metrics 16:12:52 ERROR - PROCESS | 22038 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:12:53 INFO - TEST-INFO | 22038: exit 0 16:12:53 INFO - Browser initialized. 16:12:53 INFO - Running cycle 1/1 for kraken test... 16:12:53 INFO - TEST-INFO | started process 22119 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpklVQx4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:05 INFO - PROCESS | 22119 | RSS: Main: 152993792 16:13:05 INFO - PROCESS | 22119 | 16:13:07 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51400/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:08 INFO - PROCESS | 22119 | RSS: Main: 194109440 16:13:08 INFO - PROCESS | 22119 | 16:13:11 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51400/tests/kraken/driver.html?testName=audio-dft) 16:13:11 INFO - PROCESS | 22119 | RSS: Main: 183836672 16:13:11 INFO - PROCESS | 22119 | 16:13:14 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51400/tests/kraken/driver.html?testName=audio-fft) 16:13:15 INFO - PROCESS | 22119 | RSS: Main: 167297024 16:13:15 INFO - PROCESS | 22119 | 16:13:17 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51400/tests/kraken/driver.html?testName=audio-oscillator) 16:13:17 INFO - PROCESS | 22119 | RSS: Main: 170491904 16:13:17 INFO - PROCESS | 22119 | 16:13:19 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:20 INFO - PROCESS | 22119 | RSS: Main: 172498944 16:13:20 INFO - PROCESS | 22119 | 16:13:23 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51400/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:24 INFO - PROCESS | 22119 | RSS: Main: 172650496 16:13:24 INFO - PROCESS | 22119 | 16:13:27 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51400/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:27 INFO - PROCESS | 22119 | RSS: Main: 173703168 16:13:27 INFO - PROCESS | 22119 | 16:13:30 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51400/tests/kraken/driver.html?testName=json-parse-financial) 16:13:31 INFO - PROCESS | 22119 | RSS: Main: 173289472 16:13:31 INFO - PROCESS | 22119 | 16:13:32 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:33 INFO - PROCESS | 22119 | RSS: Main: 182722560 16:13:33 INFO - PROCESS | 22119 | 16:13:35 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:35 INFO - PROCESS | 22119 | RSS: Main: 181473280 16:13:35 INFO - PROCESS | 22119 | 16:13:37 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:38 INFO - PROCESS | 22119 | RSS: Main: 190550016 16:13:38 INFO - PROCESS | 22119 | 16:13:40 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:41 INFO - PROCESS | 22119 | RSS: Main: 197050368 16:13:41 INFO - PROCESS | 22119 | 16:13:43 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:44 INFO - PROCESS | 22119 | RSS: Main: 196788224 16:13:44 INFO - PROCESS | 22119 | 16:13:45 INFO - PROCESS | 22119 | Cycle 1(1): loaded http://localhost:51400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51400/tests/kraken/driver.html?testName=ai-astar) 16:13:46 INFO - PROCESS | 22119 | RSS: Main: 258396160 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | __start_tp_report 16:13:46 INFO - PROCESS | 22119 | _x_x_mozilla_page_load 16:13:46 INFO - PROCESS | 22119 | _x_x_mozilla_page_load_details 16:13:46 INFO - PROCESS | 22119 | |i|pagename|runs| 16:13:46 INFO - PROCESS | 22119 | |0;ai-astar;111;111;106;110;112;111;101;109;110;109 16:13:46 INFO - PROCESS | 22119 | |1;audio-beat-detection;158;130;156;168;130;160;148;132;173;127 16:13:46 INFO - PROCESS | 22119 | |2;audio-dft;162;161;161;161;160;162;161;163;160;165 16:13:46 INFO - PROCESS | 22119 | |3;audio-fft;76;73;100;94;74;76;74;128;94;73 16:13:46 INFO - PROCESS | 22119 | |4;audio-oscillator;93;92;151;103;93;92;142;93;93;139 16:13:46 INFO - PROCESS | 22119 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 16:13:46 INFO - PROCESS | 22119 | |6;imaging-darkroom;146;145;145;145;146;145;144;146;144;146 16:13:46 INFO - PROCESS | 22119 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 16:13:46 INFO - PROCESS | 22119 | |8;json-parse-financial;58;58;56;56;57;57;58;71;55;53 16:13:46 INFO - PROCESS | 22119 | |9;json-stringify-tinderbox;60;61;61;61;60;61;61;61;62;60 16:13:46 INFO - PROCESS | 22119 | |10;stanford-crypto-aes;76;78;79;77;79;79;77;77;78;76 16:13:46 INFO - PROCESS | 22119 | |11;stanford-crypto-ccm;110;109;112;118;111;112;112;112;109;119 16:13:46 INFO - PROCESS | 22119 | |12;stanford-crypto-pbkdf2;147;142;146;141;141;131;147;142;146;131 16:13:46 INFO - PROCESS | 22119 | |13;stanford-crypto-sha256-iterative;63;65;65;64;68;61;62;61;61;62 16:13:46 INFO - PROCESS | 22119 | __end_tp_report 16:13:46 INFO - PROCESS | 22119 | __start_cc_report 16:13:46 INFO - PROCESS | 22119 | _x_x_mozilla_cycle_collect,1078 16:13:46 INFO - PROCESS | 22119 | __end_cc_report 16:13:46 INFO - PROCESS | 22119 | __startTimestamp1459638826173__endTimestamp 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | ------- Summary: start ------- 16:13:46 INFO - PROCESS | 22119 | Number of tests: 14 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.27 (3.0%) stddev-sans-first:3.38 16:13:46 INFO - PROCESS | 22119 | Values: 111.0 111.0 106.0 110.0 112.0 111.0 101.0 109.0 110.0 109.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:157.00 stddev:17.25 (11.0%) stddev-sans-first:17.93 16:13:46 INFO - PROCESS | 22119 | Values: 158.0 130.0 156.0 168.0 130.0 160.0 148.0 132.0 173.0 127.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 16:13:46 INFO - PROCESS | 22119 | Values: 162.0 161.0 161.0 161.0 160.0 162.0 161.0 163.0 160.0 165.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#3] audio-fft Cycles:10 Average:86.20 Median:75.00 stddev:17.99 (24.0%) stddev-sans-first:18.70 16:13:46 INFO - PROCESS | 22119 | Values: 76.0 73.0 100.0 94.0 74.0 76.0 74.0 128.0 94.0 73.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.50 stddev:24.47 (26.5%) stddev-sans-first:25.26 16:13:46 INFO - PROCESS | 22119 | Values: 93.0 92.0 151.0 103.0 93.0 92.0 142.0 93.0 93.0 139.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:13:46 INFO - PROCESS | 22119 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 16:13:46 INFO - PROCESS | 22119 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 144.0 146.0 144.0 146.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:13:46 INFO - PROCESS | 22119 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:4.86 (8.5%) stddev-sans-first:5.16 16:13:46 INFO - PROCESS | 22119 | Values: 58.0 58.0 56.0 56.0 57.0 57.0 58.0 71.0 55.0 53.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 16:13:46 INFO - PROCESS | 22119 | Values: 60.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 62.0 60.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:1.17 (1.5%) stddev-sans-first:1.09 16:13:46 INFO - PROCESS | 22119 | Values: 76.0 78.0 79.0 77.0 79.0 79.0 77.0 77.0 78.0 76.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#11] stanford-crypto-ccm Cycles:10 Average:112.40 Median:112.00 stddev:3.44 (3.1%) stddev-sans-first:3.54 16:13:46 INFO - PROCESS | 22119 | Values: 110.0 109.0 112.0 118.0 111.0 112.0 112.0 112.0 109.0 119.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:144.00 stddev:5.99 (4.2%) stddev-sans-first:6.00 16:13:46 INFO - PROCESS | 22119 | Values: 147.0 142.0 146.0 141.0 141.0 131.0 147.0 142.0 146.0 131.0 16:13:46 INFO - PROCESS | 22119 | 16:13:46 INFO - PROCESS | 22119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:2.30 (3.6%) stddev-sans-first:2.44 16:13:46 INFO - PROCESS | 22119 | Values: 63.0 65.0 65.0 64.0 68.0 61.0 62.0 61.0 61.0 62.0 16:13:46 INFO - PROCESS | 22119 | -------- Summary: end -------- 16:13:46 INFO - PROCESS | 22119 | 16:13:47 INFO - TEST-INFO | 22119: exit 0 16:13:47 INFO - TEST-OK | kraken | took 59108ms 16:13:47 INFO - SUITE-END | took 1170s 16:13:47 INFO - Completed test suite (00:19:30) 16:13:47 INFO - javascript benchmark 16:13:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3094.690530946905, 3144.7798654094195, 3183.570218020568, 3185.2833112549665, 3216.195951012247, 5180.922286165701, 5278.049951008817, 5294.0, 5310.486086826196, 5381.408045115039, 5297.788088476456, 5307.787688492455, 5379.946200537994, 5405.783768649249, 5424.620276580641, 4714.858554243361, 4805.543473370033, 4862.927056094161, 4895.11887860185, 4916.975415122919, 4863.829765958192, 4876.707397556158, 4912.7297998610065, 4912.9191577853, 4970.179920313162, 4697.812087516495, 4729.976350118227, 4819.397575303087, 4829.565339119478, 4835.1296766582, 4797.496262892381, 4805.231163013936, 4806.7836947337455, 4855.028994201139, 4863.659543831933, 4771.045790841811, 4771.6182705383835, 4797.64017698674, 4802.807887684523, 4845.3216549683075, 5147.176451767699, 5152.562032227228, 5251.921221181686, 5268.6575372600655, 5293.153095504701, 5615.2700148980775, 5661.971690141523, 5662.462066103755, 5663.5186009189265, 5672.092465205588, 5684.658920464785, 5687.232223649837, 5687.26065611472, 5700.857478563069, 5708.543316534668, 5198.298229738974, 5293.417724050351, 5331.493508116722, 5395.838124856221, 5407.70257635826, 5739.196512488255, 5756.3380211276235, 5756.798512052058, 5759.798407055733, 5815.244018277597, 5383.515483606494, 5506.201600767866, 5513.145462453326, 5516.255305533701, 5516.889662206733, 5539.446055394428, 5644.774209031675, 5663.178839068394, 5664.6601203927075, 5665.745041473061, 5624.634398764068, 5640.633358831663, 5643.040683083886, 5647.463490968352, 5648.378678345379, 5577.525910297589, 5599.048161812501, 5653.491185793298, 5655.179998900218, 5656.632318899258, 4183.0, 4228.9154216915485, 4272.829086836554, 4277.679174061957, 4292.978535107304, 3812.3519001769764, 3828.1769419574925, 3841.4814000110186, 3864.0, 3865.014421322545, 5215.921761173586, 5314.0700377433795, 5319.734013299397, 5325.733713314319, 5375.596830237748, 5599.944000559943, 5668.943310566924, 5679.233303503974, 5706.885862282731, 5716.942830571724, 5274.393444753902, 5274.630775845654, 5284.973575132177, 5293.708846013506, 5304.257403963448, 4640.721556706609, 4684.063187362473, 4684.063187362541, 4694.976525117352, 4733.763311834395, 5826.359100498942, 5839.854003649943, 5846.356900740915, 5856.297244330707, 5905.793297234576, 5640.125780504029, 5651.406602306699, 5656.208130861765, 5656.2929633795775, 5656.406077361982, 5714.514266287412, 5744.080947048452, 5796.884062318814, 5826.475617194473, 5828.679422631626, 5554.75003624846, 5556.611037227517, 5572.052751032254, 5601.29983752031, 5612.8877422450505, 5686.488216060575, 5694.231278777312, 5718.599698021098, 5719.8570035749435, 5720.856978575569, 5419.105847535113, 5520.779168833202, 5545.528630066328, 5635.9436405635415, 5648.604597678123, 5534.833954981357, 5541.639793413416, 5546.916796248141, 5548.250986116823, 5549.056660367828, 5430.484104010113, 5470.316210473691, 5475.589330800286, 5486.039943009878, 5530.6128570999645, 5318.441563635763, 5452.2094296327605, 5457.754401052041, 5541.33503979525, 5581.916271255853, 5354.651947623392, 5480.232767412645, 5491.670499770026, 5492.835214943558, 5554.944450555605], "unit": "score", "name": "dojo.html", "value": 5208.874364387574}, {"lowerIsBetter": false, "replicates": [557.9135234038725, 562.5190462154858, 576.4293349583911, 578.9044807606745, 633.8700566383892, 30271.394572108544, 41723.0, 42495.78752106239, 42599.509017184406, 42616.78691606545, 45404.318935216, 45437.318440223426, 45935.31097033539, 46012.769936150355, 46071.308930366074, 8705.303575713944, 8898.86651700225, 8907.554622268894, 8917.643294268222, 8995.41529800564, 8680.435771674853, 8824.117588241188, 8835.911640883573, 8844.513551754651, 8845.380823342368, 8821.51481668508, 8844.380893337437, 8915.153060459246, 8917.286617070618, 8923.464592124494, 8816.206541411271, 8845.203931646183, 8855.512946787892, 8899.02110767815, 8909.420887642314, 8836.779080522974, 8876.911230887674, 8967.282617390592, 8981.371304008722, 8985.955070224672, 41594.1681166375, 41917.580824191675, 41936.0, 41979.7901010493, 42021.36967945483, 3666.4866918631415, 3703.518542589473, 3778.131029863147, 3819.2361527694293, 4304.956950430487, 31069.533956990665, 31383.843080784678, 32161.678383216335, 32230.838845805854, 32237.838810805795, 4143.544210136883, 4147.151875158326, 4222.78886055696, 4264.147170565868, 4367.58507941745, 330869.0, 331301.0, 331677.0, 331944.0, 332157.0, 53981.46018539764, 57607.711961440764, 58935.0, 58946.11580826291, 65449.67275163689, 61527.0, 61711.07433388503, 61738.0, 61866.0, 61930.0, 16089.919550402174, 16228.837711622733, 16238.188090595422, 16274.349026039063, 16588.917055414644, 11554.248973816675, 12812.61562153137, 12846.0, 12896.48414063427, 12961.481540738265, 18805.435836924913, 19099.90450047741, 19186.232550698096, 19669.22976932083, 19857.702134467996, 7185.640717964081, 7459.254074592606, 7478.663460144307, 7511.0610130945, 7548.4716069874585, 1011.8026984737905, 1027.5222021759917, 1083.788661211072, 1107.5625128074525, 1192.1714408486018, 30787.538186927213, 30959.535606965914, 31168.376632467676, 31208.0, 31489.527657085164, 1082.8429877667852, 1145.1869172887177, 1161.2916121166081, 1207.2877002568528, 1224.6448529926222, 15412.691746165014, 15682.529524114294, 15851.024208566108, 16119.435819746253, 16307.021578705315, 362392.0, 369275.0, 371774.0, 375319.0, 391648.0, 52879.735601322514, 53051.0, 53543.19685204647, 53684.73157634265, 53854.0, 1387.6322774464775, 1389.3539504130426, 1389.4442223110836, 1402.8737413632823, 1410.4287763455611, 29020.709792901802, 29298.707012930452, 29563.85218073896, 29598.704012959595, 30031.0, 45057.774711126236, 45096.323555147355, 45419.09161816811, 45456.772716136205, 45515.54484455113, 295525.0, 309911.0, 311083.0, 312347.0, 312443.0, 47014.76492617515, 47733.76133119312, 47816.282755757995, 48355.758221210075, 48545.5145448541, 45603.77198113988, 45797.31304030509, 45882.54117458916, 47120.7643961778, 47273.763631181624, 38933.22133557256, 40367.3944890821, 40509.797451013736, 40583.39124913188, 40741.38887916743, 39344.21311573695, 40434.39348409717, 40797.1840563193, 41577.0, 41919.58080419279, 39718.60281397149, 40283.0, 40965.0, 41152.1769564613, 41586.168276634904, 34473.310533789685, 36922.8153859229, 37473.62526374702, 38115.61884381121, 38128.37780410857, 28696.426071478036, 29384.412311753218, 29900.70099298979, 29901.850490747405, 29946.25134371658], "unit": "score", "name": "ext.html", "value": 19856.691094744667}, {"lowerIsBetter": false, "replicates": [343.0531732418524, 346.31602584894836, 348.2304107921493, 350.36583783352137, 353.8089431706878, 17137.82862171378, 17698.292068317267, 18056.09719514024, 18762.906185469055, 18764.71852922207, 18068.0, 18184.54538636535, 18449.169787359566, 18461.815381846176, 18464.907675461636, 4539.364488971547, 5708.8858222835515, 5716.056850619642, 5720.8283751487525, 5721.141828725683, 5598.188262701906, 5644.887102257952, 5665.036943719578, 5668.68822214778, 5674.177244299574, 5378.220158077076, 5600.327960644708, 5609.52319052881, 5609.719514024303, 5611.466910643503, 5482.150266708666, 5531.3362396512275, 5534.778608855661, 5537.418571050042, 5539.086050801613, 4847.030593881203, 4997.825076122354, 5075.898482030376, 5076.035553244908, 5077.695338279715, 13094.934525327313, 13111.475540978445, 16036.037837729773, 21128.788712112837, 21149.5770084599, 2051.507638166844, 2175.7715439878903, 2260.9660855087186, 2583.225032490245, 2861.78536609753, 9172.6789562365, 9243.584038718274, 9379.155875971195, 9432.103950124727, 9629.470379129145, 1923.923043078289, 1924.2976313645418, 2001.9099140538565, 2013.2953466286829, 2021.989890050555, 54089.45910540884, 66094.0, 68876.6556167221, 69072.65463672699, 70546.64726676384, 9464.47945362998, 10026.19790416765, 10281.53733082013, 10381.896181038244, 10382.948085259526, 12148.299238106672, 14132.858671413154, 14223.075500092667, 14224.786628200585, 14229.64425889361, 9413.90586094144, 9440.716778496657, 9656.37233579815, 9702.369345992487, 10036.046575575308, 7904.683812647545, 8067.556284404414, 8132.75601731949, 8184.836303273901, 8337.207965243293, 7692.653830577638, 8017.318527925192, 8063.6774529018185, 8180.181981801772, 8186.263236308641, 3017.5926249956415, 3076.661567227603, 3099.0, 3133.8433078345993, 3179.7456203504125, 869.1959937058323, 893.4639216470066, 990.1830989433602, 994.572333896417, 1068.0921216965517, 16752.329906803836, 17402.65194696099, 17686.569013805187, 17742.556436088944, 18040.368587099387, 952.1002652493328, 973.493783232715, 1044.1385856668278, 1064.4305296666246, 1087.4127970895627, 9663.178629816544, 9789.461579613047, 10061.0, 10183.287169898183, 10241.283110182216, 451827.0, 464710.0, 473104.0, 473716.0, 479849.0, 81377.59311203405, 81447.0, 81918.18081819106, 82089.0, 82107.0, 1066.1151244467228, 1076.0261962923723, 1104.629948967105, 1116.4696769034645, 1125.0605744203517, 15840.207989600704, 15878.206089695237, 16036.679266414372, 16179.919100404422, 16435.178241088135, 27985.580216297178, 36070.21262767372, 36352.63647363493, 36416.0, 36786.63213367832, 51445.22832157595, 52132.73933630308, 53031.469685302654, 53057.73471132619, 53171.46828531665, 8025.2777250047775, 8038.598070096588, 8071.313938315309, 8309.626066827128, 8440.240378365976, 8991.28069754405, 11825.526978920747, 12177.634670959886, 12295.446704898122, 12315.261084334968, 10979.945100274448, 11007.504662290055, 11055.115590752559, 11119.0, 11199.440027998731, 5836.737346819318, 7567.978322926555, 10979.505922233358, 11144.888551114385, 11411.543538258376, 11364.772704545698, 11637.476313565741, 11711.531538738354, 11750.412479375826, 11766.88233117658, 7841.607919603883, 8043.316318113026, 8188.426810123472, 8209.070868346053, 8326.70856520019, 10293.0, 11295.3787541686, 11355.37545435009, 11515.19393642437, 11579.8263026053], "unit": "score", "name": "jquery.html", "value": 8920.918702651557}, {"lowerIsBetter": false, "replicates": [1315.5066849931275, 1337.7792664210406, 1361.3125371687297, 1441.9783703244452, 1673.7740405045322, 7464.402847772179, 7715.729949451763, 7738.883916741253, 7769.650365733542, 7774.766756997285, 7491.587962662052, 7519.0, 7591.468597198198, 7597.050368703912, 7597.164311925698, 1924.4996300961711, 2141.764405915348, 2152.698622192894, 2168.7072245246845, 2192.6162921488753, 2158.2985529702833, 2160.1899287767087, 2164.7943445372666, 2164.9025793839314, 2165.28545579959, 2072.2643461571074, 2171.6742488626755, 2172.228858755143, 2175.6083904897114, 2178.18318130701, 2132.562824620949, 2168.5879682860286, 2168.913243470259, 2178.6514157734846, 2192.1341070277313, 2070.5858828234414, 2076.719642848211, 2081.7293751812317, 2081.885496297703, 2093.3510611710267, 7742.651580678883, 7775.183605721431, 7786.416018798613, 7795.298423141944, 7810.453268271223, 4751.073540659573, 4869.196582563873, 4875.853724388274, 4879.194932836078, 4881.096997055521, 3060.3114299282706, 3092.072378286505, 3125.9531107033413, 3131.874725010997, 3160.288934989632, 965.1940629574314, 968.5351031504847, 980.294188184506, 995.3132338686283, 1018.7453136715822, 11003.33979961205, 11086.61196858114, 11096.33421994683, 11099.44502774858, 11106.833397499044, 3995.2808494471274, 4144.937825932613, 4158.293090174678, 4173.1862286853775, 4191.036061705764, 9357.812843743088, 9462.716118516455, 9468.14786669203, 9482.19401350893, 9484.668036618823, 4384.47386313638, 4792.0895029944195, 4808.230683090689, 4824.831130910401, 4829.420469543677, 4299.398084268205, 4308.590683885026, 4352.064306174188, 4363.127374525107, 4363.258246098171, 3408.0968543336035, 3465.8267086645565, 3487.459443786217, 3525.7355698322726, 3543.7165026797793, 1075.9731006724737, 1085.403028334413, 1088.7169335972703, 1089.536946797608, 1101.031092638489, 1381.6614929342174, 1384.4254634326642, 1409.4080486195821, 1439.1365180891382, 1439.7768345906402, 7641.312281894545, 7822.6088695564995, 7829.921700783033, 7834.725784597512, 7836.882446763303, 1135.5968631135993, 1142.5258517715222, 1171.3264872698232, 1172.6657902497918, 1183.0594677231622, 5995.940040599538, 6079.513638908877, 6094.238220222473, 6112.51099912006, 6119.877602447926, 9287.349885508085, 9674.322797404115, 9683.709488715349, 9699.660511882192, 9816.361936474106, 9592.232621390272, 9660.082292182231, 9666.854997175047, 9672.129508344142, 9689.806203876024, 7226.891596626055, 7423.183449820515, 7451.329380355685, 7486.513376630611, 7540.585267810323, 7340.1191856975365, 7382.6677799498075, 7452.515586486861, 7468.141163766019, 7474.476786624884, 8402.277533105576, 8629.568521574021, 8737.56312184401, 8848.0, 8881.955590222007, 8487.151284871463, 8667.82664346697, 8802.33982451306, 8809.471431714117, 8811.735647930573, 6408.0, 6707.0, 6862.4853136014, 6912.205096413977, 7023.086998690342, 7500.1374841893885, 7518.924810751822, 7534.095908491016, 7545.396368290414, 7562.432817538596, 6491.545591808528, 6580.243272023587, 6646.60120392778, 6683.264840867403, 6762.52662313653, 6383.329750376143, 6391.392817682313, 6628.966855165886, 6688.264290928091, 6707.429868461236, 7197.8587194261945, 7216.097987751531, 7336.96331518339, 7341.375983041501, 7341.632918353954, 6685.933140668531, 6758.662066896733, 6768.08630834831, 6772.322767723188, 6772.93227067723, 6886.208086070166, 6900.309969003059, 6909.7581584644295, 6912.274211207952, 6923.030775691306], "unit": "score", "name": "mootools.html", "value": 4500.332444037094}, {"lowerIsBetter": false, "replicates": [311.8581045624241, 314.859887350129, 318.09977762930896, 321.5835493036518, 322.17201791396104, 5805.274340707411, 5954.136650185726, 5993.520518358532, 6018.488428483584, 6102.237220347457, 5843.18195452637, 5904.881902361961, 5927.911081333784, 5928.081147422156, 5940.821775346746, 4299.591538803808, 4366.279563871957, 4438.312061630436, 4478.171538265415, 4479.641628669707, 4465.5311192324825, 4473.261911784552, 4474.217012022899, 4481.193385190664, 4484.618807401374, 4417.602415782579, 4427.778611069433, 4428.3800267962515, 4428.889277768066, 4442.11157768446, 4265.488141423018, 4320.546342634009, 4346.521882592912, 4405.31717583775, 4435.844745433894, 3792.924141517154, 3804.201117765245, 3807.5240594925635, 3810.0093975566274, 3810.6760925321105, 5531.640443371209, 5564.4991950724225, 5618.185363122325, 5647.491725744702, 5648.661080335193, 5060.114479965991, 5086.949130508685, 5088.313077734496, 5088.6946783193125, 5099.643024988252, 6127.448529632355, 6141.109539116803, 6153.661548614825, 6155.138280640714, 6167.907481387782, 4135.77253251071, 4228.429162063113, 4230.51349094855, 4242.915141697149, 4243.702940794145, 6405.583637063576, 6426.164598602199, 6463.353664633546, 6473.126127972758, 6473.773417930397, 4280.357946308079, 4280.4863416390235, 4282.614564689131, 4286.37847512109, 4289.785510724514, 4325.589069038437, 4327.459067616548, 4332.610065094157, 4333.739975601474, 4337.60961513459, 5073.0, 5075.0, 5076.923846142311, 5077.26379674945, 5078.263651770472, 6247.375262473807, 6248.50011999039, 6248.875022499525, 6250.062490626351, 6259.6870156492905, 1486.4648726458465, 1499.8050253467197, 1529.1207555655542, 1529.7475916473657, 1533.110795738469, 928.0255731481917, 937.315759495572, 945.2910317262053, 952.1620973543238, 991.5538007896475, 5901.527877769769, 6020.819375418744, 6023.247094113236, 6030.517558595302, 6031.215941927521, 6407.615543067431, 6463.515236357198, 6464.22429308486, 6466.708998095097, 6471.449926756184, 5992.550558708114, 5992.820215393545, 5997.1304160896425, 5998.4601385875485, 6000.069989151689, 3429.2798512312197, 3457.1702791330404, 3474.2877710069374, 3474.8262586870555, 3475.669811367916, 6488.837779055561, 6672.499562532732, 6687.598744075371, 6704.061431399608, 6724.7646332378135, 6611.173603299588, 6615.735370585219, 6630.071789949411, 6631.403173714389, 6634.966825165843, 6671.199456065303, 6673.9666301668185, 6680.0981867448245, 6687.6321802301345, 6688.832779180462, 6435.292117867125, 6473.676316184266, 6480.935190648033, 6481.287058423475, 6487.610743355413, 6237.781677641261, 6395.5203359747275, 6399.584027038228, 6402.199725034371, 6441.871162576628, 6644.10304608891, 6656.633885136364, 6679.56582822115, 6684.0642310075655, 6697.732090716511, 4234.555371685929, 4264.232438161161, 4272.145570885773, 4274.700770946004, 4279.358096285582, 6454.838629034311, 6455.580387274812, 6480.351964803482, 6534.183227096613, 6534.640594767143, 6233.688315584293, 6287.371262873676, 6298.84252893663, 6304.495640348853, 6309.1167236586, 6116.877662446637, 6199.194104766351, 6221.2845522763655, 6239.06414037898, 6249.7187626557825, 6096.055111457731, 6120.357362476876, 6131.63210207389, 6134.0, 6157.322694503511, 6292.0, 6293.905591416041, 6294.0, 6294.118823364641, 6372.87254254903, 5880.911786323294, 5967.8209653710455, 6138.846528836815, 6143.96928015357, 6146.508279337731], "unit": "score", "name": "prototype.html", "value": 4652.340885964136}, {"lowerIsBetter": false, "replicates": [720.4812534974819, 738.7451329291392, 781.945263831532, 810.3800592546702, 839.9878146833065, 13845.307734613267, 14114.0, 14121.505747298846, 14166.36251368687, 16714.164291785422, 14553.927230363834, 14644.487442939499, 14663.0, 14807.555773326818, 14849.480268190615, 646.1277275677844, 724.065954918155, 741.7033186725326, 757.178461369412, 766.1840140250644, 738.656524716007, 750.1897950213784, 754.2193829386586, 759.8708219602653, 764.4610549562545, 774.0517865614634, 778.5212094561832, 794.7575989323254, 799.8760192170223, 802.1096582793095, 686.2828344380134, 762.5920132728991, 807.0799288810761, 807.9353651707908, 810.5420437452821, 564.6668465605271, 569.6752850875002, 573.020135568179, 575.5280669850724, 583.9211706419621, 13655.453781848713, 13779.862201378059, 13820.585382438543, 13858.930705346409, 13957.0, 12753.61739147827, 13239.86760132396, 13338.799918001238, 13393.397297121654, 13471.0, 10003.24975626831, 10019.398836069786, 10277.075063244343, 10336.586536538529, 10348.741281467948, 3643.744937854351, 3682.760620559655, 3757.755745876509, 3790.3935370340887, 3817.522809648794, 55055.44944550543, 55452.44547554554, 55477.722611387086, 55777.72111139418, 55788.0, 10134.341267817568, 10670.35977841332, 10678.305910115818, 10863.348199108079, 11093.168012399103, 18117.818821811878, 18138.727919081226, 18159.546011349823, 18246.270149194148, 18285.90857045733, 8419.579021048923, 8468.026176989602, 8576.957115214509, 8714.782130446789, 8751.037385887546, 4833.492483289204, 4877.68295060827, 4972.825951091694, 4982.177940639826, 4994.825181118644, 3218.935621287561, 3237.5143728440453, 3240.902772916816, 3260.951085733716, 3277.721393681516, 586.2964442668814, 603.728322254987, 607.0833042106451, 610.703808652803, 612.2958597612692, 655.4887187993373, 742.8105833012547, 750.7372419653187, 763.2253262938123, 783.1815752538497, 8711.738647840575, 8782.780430489289, 8889.955550222208, 8997.595108220146, 9147.753703023625, 639.5682914033102, 698.7305242455595, 711.2283172757616, 758.040465396955, 780.2314720000795, 4094.651954583834, 4154.667626589866, 4180.184863951561, 4182.769947652909, 4265.978670106691, 67180.32819671741, 67393.0, 67597.66201169061, 67676.66161669258, 67977.66011170011, 55086.62283442946, 58987.0, 59460.40539594635, 59496.0, 59601.40398596045, 49953.50046499561, 51061.23408148881, 51066.0, 51667.74166129145, 51964.0, 8235.0, 8310.418270720991, 8317.542535160383, 8491.19333663301, 8573.356998225034, 39725.602743973344, 40154.1969160621, 40623.796881015405, 40963.38554921619, 41196.79401602973, 43649.34525982049, 46220.30669540027, 46392.0, 52383.0, 52430.73784631053, 11789.351585662871, 11812.527498899948, 11824.645260642195, 12010.459529321026, 12286.078544109048, 13209.933950330187, 13574.59276221715, 13636.318204080128, 13694.589162325146, 13898.791518127035, 12369.752604948031, 12513.499460021498, 12730.23618582888, 13265.336733163496, 13554.86445135536, 12756.234625922474, 12943.09398342107, 13072.346382680638, 13271.336433178109, 13509.121907076009, 12136.696582585506, 12318.322492263012, 12359.814602781145, 12461.501539938663, 12714.87285127137, 10329.74175645615, 10632.734181645212, 10674.0, 11001.669949901196, 11146.331220126818, 10626.8405973912, 10662.46687665598, 10845.783084338427, 10881.075108615856, 11003.834942475709], "unit": "score", "name": "yui.html", "value": 6691.662938862984}], "name": "dromaeo_css", "value": 7110.914532373045}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 110.0, 112.0, 111.0, 101.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [158.0, 130.0, 156.0, 168.0, 130.0, 160.0, 148.0, 132.0, 173.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 163.0, 160.0, 165.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 100.0, 94.0, 74.0, 76.0, 74.0, 128.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 151.0, 103.0, 93.0, 92.0, 142.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.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": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0, 146.0, 144.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 56.0, 56.0, 57.0, 57.0, 58.0, 71.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.8}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 79.0, 77.0, 79.0, 79.0, 77.0, 77.0, 78.0, 76.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 112.0, 118.0, 111.0, 112.0, 112.0, 112.0, 109.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.4}, {"lowerIsBetter": true, "replicates": [147.0, 142.0, 146.0, 141.0, 141.0, 131.0, 147.0, 142.0, 146.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 65.0, 64.0, 68.0, 61.0, 62.0, 61.0, 61.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.2}], "name": "kraken", "value": 1484.6}]} 16:13:47 INFO - Return code: 0 16:13:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:13:47 ERROR - # TBPL SUCCESS # 16:13:47 INFO - Running post-action listener: _resource_record_post_action 16:13:47 INFO - Running post-run listener: _resource_record_post_run 16:13:48 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527503360; Read time: 12; Write time: 475024 16:13:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243011584; Read time: 0; Write time: 234296 16:13:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284491776; Read time: 12; Write time: 240728 16:13:48 INFO - Running post-run listener: _upload_blobber_files 16:13:48 INFO - Blob upload gear active. 16:13:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:13:48 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 16:13:48 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'] 16:13:48 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 16:13:48 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:49 INFO - (blobuploader) - INFO - Done attempting. 16:13:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:50 INFO - (blobuploader) - INFO - Done attempting. 16:13:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:50 INFO - Return code: 0 16:13:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:13:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/add42ab3638247b639b3713bda1a69ecc05d526b0f0724a6b08f4de6ed54fa6ea3dc88867a02ec34759424e4181556516adc12d357d4b59a38064b2f6648addd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f37e9d31444e1d440a52e72785f38770f9605c533eca14b0879de153b278ac182ec7bfab8fea798332b93eed75db7bb401910b24366bf938046bcf114b748aae"} 16:13:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:13:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:13:50 INFO - Contents: 16:13:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/add42ab3638247b639b3713bda1a69ecc05d526b0f0724a6b08f4de6ed54fa6ea3dc88867a02ec34759424e4181556516adc12d357d4b59a38064b2f6648addd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f37e9d31444e1d440a52e72785f38770f9605c533eca14b0879de153b278ac182ec7bfab8fea798332b93eed75db7bb401910b24366bf938046bcf114b748aae"} 16:13:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:50 INFO - Copying logs to upload dir... 16:13:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:13:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.988200 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-02 16:13:50.583962) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 16:13:50.587204) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 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/add42ab3638247b639b3713bda1a69ecc05d526b0f0724a6b08f4de6ed54fa6ea3dc88867a02ec34759424e4181556516adc12d357d4b59a38064b2f6648addd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f37e9d31444e1d440a52e72785f38770f9605c533eca14b0879de153b278ac182ec7bfab8fea798332b93eed75db7bb401910b24366bf938046bcf114b748aae"} build_url:https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/NFgW0QUJREOJhjhET-1tIg/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/add42ab3638247b639b3713bda1a69ecc05d526b0f0724a6b08f4de6ed54fa6ea3dc88867a02ec34759424e4181556516adc12d357d4b59a38064b2f6648addd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f37e9d31444e1d440a52e72785f38770f9605c533eca14b0879de153b278ac182ec7bfab8fea798332b93eed75db7bb401910b24366bf938046bcf114b748aae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 16:13:50.616534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 16:13:50.616892) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459636007.308433-2137487980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 16:13:50.704705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 16:13:50.705458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 16:13:50.706193) ========= ========= Total master_lag: 0.34 =========