builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1467091818.61 results: success (0) buildid: 20160627193059 builduid: a0049d866ef34702b10d0c6e3b2f3f51 revision: ff3138a7b682cb02dae61c0dca0f327886c57e84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.608044) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.608561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.608852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.662841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.663100) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 22:30:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-06-27 22:30:19 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.789753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.790087) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019781 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.841912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:18.842268) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ff3138a7b682cb02dae61c0dca0f327886c57e84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ff3138a7b682cb02dae61c0dca0f327886c57e84 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 22:30:19,337 truncating revision to first 12 chars 2016-06-27 22:30:19,337 Setting DEBUG logging. 2016-06-27 22:30:19,337 attempt 1/10 2016-06-27 22:30:19,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ff3138a7b682?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 22:30:19,655 unpacking tar archive at: mozilla-inbound-ff3138a7b682/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673845 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:19.530274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:19.530739) ========= script_repo_revision: ff3138a7b682cb02dae61c0dca0f327886c57e84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:19.531351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:19.531810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 22:30:19.543857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-27 22:30:19.544316) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:30:20 INFO - MultiFileLogger online at 20160627 22:30:20 in /builds/slave/test 22:30:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:30:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:30:20 INFO - {'append_to_log': False, 22:30:20 INFO - 'base_work_dir': '/builds/slave/test', 22:30:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:30:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:30:20 INFO - 'branch': 'Mozilla-Inbound', 22:30:20 INFO - 'buildbot_json_path': 'buildprops.json', 22:30:20 INFO - 'config_files': ('talos/linux_config.py',), 22:30:20 INFO - 'default_actions': ('clobber', 22:30:20 INFO - 'read-buildbot-config', 22:30:20 INFO - 'download-and-extract', 22:30:20 INFO - 'populate-webroot', 22:30:20 INFO - 'create-virtualenv', 22:30:20 INFO - 'install', 22:30:20 INFO - 'run-tests'), 22:30:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:30:20 INFO - 'download_minidump_stackwalk': True, 22:30:20 INFO - 'download_symbols': 'ondemand', 22:30:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:30:20 INFO - 'tooltool.py': '/tools/tooltool.py', 22:30:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:30:20 INFO - '/tools/misc-python/virtualenv.py')}, 22:30:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:30:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:30:20 INFO - 'installer_path': 'installer.exe', 22:30:20 INFO - 'log_level': 'info', 22:30:20 INFO - 'log_name': 'talos', 22:30:20 INFO - 'log_to_console': True, 22:30:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:30:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:30:20 INFO - 'opt_config_files': (), 22:30:20 INFO - 'pip_index': False, 22:30:20 INFO - 'sps_profile': False, 22:30:20 INFO - 'sps_profile_interval': 0, 22:30:20 INFO - 'suite': 'dromaeojs-e10s', 22:30:20 INFO - 'system_bits': '32', 22:30:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:30:20 INFO - 'title': 'talos-linux64-ix-065', 22:30:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:30:20 INFO - 'use_talos_json': True, 22:30:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:30:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:30:20 INFO - 'work_dir': 'build'} 22:30:20 INFO - ##### 22:30:20 INFO - ##### Running clobber step. 22:30:20 INFO - ##### 22:30:20 INFO - Running pre-action listener: _resource_record_pre_action 22:30:20 INFO - Running main action method: clobber 22:30:20 INFO - rmtree: /builds/slave/test/build 22:30:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:30:21 INFO - Running post-action listener: _resource_record_post_action 22:30:21 INFO - ##### 22:30:21 INFO - ##### Finished clobber step (success) 22:30:21 INFO - ##### 22:30:21 INFO - ##### 22:30:21 INFO - ##### Running read-buildbot-config step. 22:30:21 INFO - ##### 22:30:21 INFO - Running pre-action listener: _resource_record_pre_action 22:30:21 INFO - Running main action method: read_buildbot_config 22:30:21 INFO - Using buildbot properties: 22:30:21 INFO - { 22:30:21 INFO - "project": "", 22:30:21 INFO - "product": "firefox", 22:30:21 INFO - "script_repo_revision": "production", 22:30:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:30:21 INFO - "repository": "", 22:30:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:30:21 INFO - "buildid": "20160627193059", 22:30:21 INFO - "pgo_build": "True", 22:30:21 INFO - "basedir": "/builds/slave/test", 22:30:21 INFO - "buildnumber": 919, 22:30:21 INFO - "slavename": "talos-linux64-ix-065", 22:30:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:30:21 INFO - "platform": "ubuntu64_hw", 22:30:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:30:21 INFO - "branch": "mozilla-inbound", 22:30:21 INFO - "repo_path": "integration/mozilla-inbound", 22:30:21 INFO - "revision": "ff3138a7b682cb02dae61c0dca0f327886c57e84", 22:30:21 INFO - "stage_platform": "linux64-pgo", 22:30:21 INFO - "builduid": "a0049d866ef34702b10d0c6e3b2f3f51", 22:30:21 INFO - "slavebuilddir": "test" 22:30:21 INFO - } 22:30:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:30:21 INFO - Running post-action listener: _resource_record_post_action 22:30:21 INFO - ##### 22:30:21 INFO - ##### Finished read-buildbot-config step (success) 22:30:21 INFO - ##### 22:30:21 INFO - ##### 22:30:21 INFO - ##### Running download-and-extract step. 22:30:21 INFO - ##### 22:30:21 INFO - Running pre-action listener: _resource_record_pre_action 22:30:21 INFO - Running main action method: download_and_extract 22:30:21 INFO - mkdir: /builds/slave/test/build/tests 22:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:21 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:30:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:30:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:30:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:30:32 INFO - Downloaded 1361 bytes. 22:30:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:30:32 INFO - Using the following test package requirements: 22:30:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:30:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:30:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:30:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'jsshell-linux-x86_64.zip'], 22:30:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:30:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:30:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:30:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:30:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:30:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:30:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:32 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:30:43 INFO - Downloaded 24282915 bytes. 22:30:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:30:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:30:44 INFO - Return code: 0 22:30:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:30:44 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')]} 22:30:44 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:30:47 INFO - Downloaded 24282915 bytes. 22:30:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:30:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:30:49 INFO - Return code: 0 22:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:49 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:30:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:30:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:30:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:30:50 INFO - Downloaded 14405240 bytes. 22:30:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:30:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:30:50 INFO - Return code: 0 22:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:50 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:30:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:30:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:30:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:30:52 INFO - Downloaded 60297917 bytes. 22:30:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:30:52 INFO - mkdir: /builds/slave/test/properties 22:30:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:30:52 INFO - Writing to file /builds/slave/test/properties/build_url 22:30:52 INFO - Contents: 22:30:52 INFO - build_url:https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:30:52 INFO - Running post-action listener: _resource_record_post_action 22:30:52 INFO - Running post-action listener: set_extra_try_arguments 22:30:52 INFO - ##### 22:30:52 INFO - ##### Finished download-and-extract step (success) 22:30:52 INFO - ##### 22:30:52 INFO - ##### 22:30:52 INFO - ##### Running populate-webroot step. 22:30:52 INFO - ##### 22:30:52 INFO - Running pre-action listener: _resource_record_pre_action 22:30:52 INFO - Running main action method: populate_webroot 22:30:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:30:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:30:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:30:52 INFO - '--tppagecycles', 22:30:52 INFO - '7'], 22:30:52 INFO - 'tests': ['tsvgm']}}, 22:30:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:30:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:30:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:30:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:30:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:30:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:30:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['damp', 'tps']}, 22:30:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'tests': ['damp', 'tps']}, 22:30:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['dromaeo_dom']}, 22:30:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:30:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['basic_compositor_video']}, 22:30:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:30:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['a11yr', 22:30:52 INFO - 'ts_paint', 22:30:52 INFO - 'tpaint', 22:30:52 INFO - 'sessionrestore', 22:30:52 INFO - 'sessionrestore_no_auto_restore', 22:30:52 INFO - 'tabpaint']}, 22:30:52 INFO - 'other-e10s': {'tests': ['a11yr', 22:30:52 INFO - 'ts_paint', 22:30:52 INFO - 'tpaint', 22:30:52 INFO - 'sessionrestore', 22:30:52 INFO - 'sessionrestore_no_auto_restore', 22:30:52 INFO - 'tabpaint']}, 22:30:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:30:52 INFO - 'ts_paint', 22:30:52 INFO - 'tpaint', 22:30:52 INFO - 'sessionrestore', 22:30:52 INFO - 'sessionrestore_no_auto_restore', 22:30:52 INFO - 'tabpaint']}, 22:30:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:30:52 INFO - 'ts_paint', 22:30:52 INFO - 'tpaint', 22:30:52 INFO - 'sessionrestore', 22:30:52 INFO - 'sessionrestore_no_auto_restore', 22:30:52 INFO - 'tabpaint']}, 22:30:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['a11yr', 22:30:52 INFO - 'ts_paint', 22:30:52 INFO - 'tpaint', 22:30:52 INFO - 'sessionrestore', 22:30:52 INFO - 'sessionrestore_no_auto_restore', 22:30:52 INFO - 'tabpaint']}, 22:30:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['a11yr', 22:30:52 INFO - 'ts_paint', 22:30:52 INFO - 'tpaint', 22:30:52 INFO - 'sessionrestore', 22:30:52 INFO - 'sessionrestore_no_auto_restore', 22:30:52 INFO - 'tabpaint']}, 22:30:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['tsvgx', 22:30:52 INFO - 'tsvgr_opacity', 22:30:52 INFO - 'tart', 22:30:52 INFO - 'tscrollx', 22:30:52 INFO - 'cart']}, 22:30:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:30:52 INFO - 'tsvgr_opacity', 22:30:52 INFO - 'tart', 22:30:52 INFO - 'tscrollx', 22:30:52 INFO - 'cart']}, 22:30:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'talos_options': ['--disable-e10s'], 22:30:52 INFO - 'tests': ['tp5o']}, 22:30:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'tests': ['tp5o']}, 22:30:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'talos_options': ['--disable-e10s', 22:30:52 INFO - '--xperf_path', 22:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:30:52 INFO - 'tests': ['tp5n']}, 22:30:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:30:52 INFO - 'talos_options': ['--xperf_path', 22:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:30:52 INFO - 'tests': ['tp5n']}}, 22:30:52 INFO - 'talos.zip': {'path': '', 22:30:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:30:52 INFO - Running post-action listener: _resource_record_post_action 22:30:52 INFO - ##### 22:30:52 INFO - ##### Finished populate-webroot step (success) 22:30:52 INFO - ##### 22:30:52 INFO - ##### 22:30:52 INFO - ##### Running create-virtualenv step. 22:30:52 INFO - ##### 22:30:52 INFO - Running pre-action listener: _resource_record_pre_action 22:30:52 INFO - Running main action method: create_virtualenv 22:30:52 INFO - Creating virtualenv /builds/slave/test/build/venv 22:30:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:30:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:30:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:30:53 INFO - Using real prefix '/usr' 22:30:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:30:53 INFO - Installing distribute.............................................................................................................................................................................................done. 22:30:55 INFO - Installing pip.................done. 22:30:55 INFO - Return code: 0 22:30:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:30: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')]} 22:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30: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')]} 22:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:30:55 INFO - Running command: ['/builds/slave/test/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/build 22:30:55 INFO - Copy/paste: /builds/slave/test/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 22:30:55 INFO - Using env: {'DISPLAY': ':0', 22:30:55 INFO - 'HOME': '/home/cltbld', 22:30:55 INFO - 'LANG': 'en_US.UTF-8', 22:30:55 INFO - 'LANGUAGE': 'en_US:en', 22:30:55 INFO - 'LOGNAME': 'cltbld', 22:30:55 INFO - 'MAIL': '/var/mail/cltbld', 22:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:55 INFO - 'MOZ_NO_REMOTE': '1', 22:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:55 INFO - 'NO_EM_RESTART': '1', 22:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:55 INFO - 'PWD': '/builds/slave/test', 22:30:55 INFO - 'SHELL': '/bin/bash', 22:30:55 INFO - 'SHLVL': '1', 22:30:55 INFO - 'TERM': 'linux', 22:30:55 INFO - 'TMOUT': '86400', 22:30:55 INFO - 'USER': 'cltbld', 22:30:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:55 INFO - '_': '/tools/buildbot/bin/python'} 22:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:55 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 22:30:55 INFO - Cleaning up... 22:30:55 INFO - Return code: 0 22:30:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:30: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')]} 22:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30: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')]} 22:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:30:55 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 22:30:55 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 22:30:55 INFO - Using env: {'DISPLAY': ':0', 22:30:55 INFO - 'HOME': '/home/cltbld', 22:30:55 INFO - 'LANG': 'en_US.UTF-8', 22:30:55 INFO - 'LANGUAGE': 'en_US:en', 22:30:55 INFO - 'LOGNAME': 'cltbld', 22:30:55 INFO - 'MAIL': '/var/mail/cltbld', 22:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:55 INFO - 'MOZ_NO_REMOTE': '1', 22:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:55 INFO - 'NO_EM_RESTART': '1', 22:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:55 INFO - 'PWD': '/builds/slave/test', 22:30:55 INFO - 'SHELL': '/bin/bash', 22:30:55 INFO - 'SHLVL': '1', 22:30:55 INFO - 'TERM': 'linux', 22:30:55 INFO - 'TMOUT': '86400', 22:30:55 INFO - 'USER': 'cltbld', 22:30:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:55 INFO - '_': '/tools/buildbot/bin/python'} 22:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:55 INFO - Downloading/unpacking psutil>=3.1.1 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:30:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:57 INFO - Installing collected packages: psutil 22:30:57 INFO - Running setup.py install for psutil 22:30:57 INFO - building 'psutil._psutil_linux' extension 22:30:57 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 22:30:58 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 22:30:58 INFO - building 'psutil._psutil_posix' extension 22:30:58 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 22:30:58 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 22:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:58 INFO - Successfully installed psutil 22:30:58 INFO - Cleaning up... 22:30:58 INFO - Return code: 0 22:30:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:30:58 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 22:30:58 INFO - Copy/paste: /builds/slave/test/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.3 22:30:58 INFO - Using env: {'DISPLAY': ':0', 22:30:58 INFO - 'HOME': '/home/cltbld', 22:30:58 INFO - 'LANG': 'en_US.UTF-8', 22:30:58 INFO - 'LANGUAGE': 'en_US:en', 22:30:58 INFO - 'LOGNAME': 'cltbld', 22:30:58 INFO - 'MAIL': '/var/mail/cltbld', 22:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:58 INFO - 'MOZ_NO_REMOTE': '1', 22:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:58 INFO - 'NO_EM_RESTART': '1', 22:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:58 INFO - 'PWD': '/builds/slave/test', 22:30:58 INFO - 'SHELL': '/bin/bash', 22:30:58 INFO - 'SHLVL': '1', 22:30:58 INFO - 'TERM': 'linux', 22:30:58 INFO - 'TMOUT': '86400', 22:30:58 INFO - 'USER': 'cltbld', 22:30:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:58 INFO - '_': '/tools/buildbot/bin/python'} 22:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:31:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:31:00 INFO - Installing collected packages: mozsystemmonitor 22:31:00 INFO - Running setup.py install for mozsystemmonitor 22:31:00 INFO - Successfully installed mozsystemmonitor 22:31:00 INFO - Cleaning up... 22:31:00 INFO - Return code: 0 22:31:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:31:00 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')]} 22:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:00 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')]} 22:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:31:00 INFO - Running command: ['/builds/slave/test/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==2.5.1'] in /builds/slave/test/build 22:31:00 INFO - Copy/paste: /builds/slave/test/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==2.5.1 22:31:00 INFO - Using env: {'DISPLAY': ':0', 22:31:00 INFO - 'HOME': '/home/cltbld', 22:31:00 INFO - 'LANG': 'en_US.UTF-8', 22:31:00 INFO - 'LANGUAGE': 'en_US:en', 22:31:00 INFO - 'LOGNAME': 'cltbld', 22:31:00 INFO - 'MAIL': '/var/mail/cltbld', 22:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:00 INFO - 'MOZ_NO_REMOTE': '1', 22:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:00 INFO - 'NO_EM_RESTART': '1', 22:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:00 INFO - 'PWD': '/builds/slave/test', 22:31:00 INFO - 'SHELL': '/bin/bash', 22:31:00 INFO - 'SHLVL': '1', 22:31:00 INFO - 'TERM': 'linux', 22:31:00 INFO - 'TMOUT': '86400', 22:31:00 INFO - 'USER': 'cltbld', 22:31:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:00 INFO - '_': '/tools/buildbot/bin/python'} 22:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:00 INFO - Downloading/unpacking jsonschema==2.5.1 22:31:00 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 22:31:00 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 22:31:00 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 22:31:00 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 22:31:00 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 22:31:00 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 22:31:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:31:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:03 INFO - Downloading functools32-3.2.3-2.tar.gz 22:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:31:03 INFO - warning: no files found matching '*.txt' 22:31:03 INFO - no previously-included directories found matching 'build' 22:31:03 INFO - no previously-included directories found matching 'dist' 22:31:03 INFO - no previously-included directories found matching '.git*' 22:31:03 INFO - Installing collected packages: jsonschema, functools32 22:31:03 INFO - Running setup.py install for functools32 22:31:03 INFO - warning: no files found matching '*.txt' 22:31:03 INFO - no previously-included directories found matching 'build' 22:31:03 INFO - no previously-included directories found matching 'dist' 22:31:03 INFO - no previously-included directories found matching '.git*' 22:31:03 INFO - Successfully installed jsonschema functools32 22:31:03 INFO - Cleaning up... 22:31:03 INFO - Return code: 0 22:31:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:31:03 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')]} 22:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:03 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')]} 22:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:31:03 INFO - Running command: ['/builds/slave/test/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/build 22:31:03 INFO - Copy/paste: /builds/slave/test/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 22:31:03 INFO - Using env: {'DISPLAY': ':0', 22:31:03 INFO - 'HOME': '/home/cltbld', 22:31:03 INFO - 'LANG': 'en_US.UTF-8', 22:31:03 INFO - 'LANGUAGE': 'en_US:en', 22:31:03 INFO - 'LOGNAME': 'cltbld', 22:31:03 INFO - 'MAIL': '/var/mail/cltbld', 22:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:03 INFO - 'MOZ_NO_REMOTE': '1', 22:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:03 INFO - 'NO_EM_RESTART': '1', 22:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:03 INFO - 'PWD': '/builds/slave/test', 22:31:03 INFO - 'SHELL': '/bin/bash', 22:31:03 INFO - 'SHLVL': '1', 22:31:03 INFO - 'TERM': 'linux', 22:31:03 INFO - 'TMOUT': '86400', 22:31:03 INFO - 'USER': 'cltbld', 22:31:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:03 INFO - '_': '/tools/buildbot/bin/python'} 22:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:03 INFO - Downloading/unpacking blobuploader==1.2.4 22:31:03 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 22:31:03 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 22:31:03 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 22:31:03 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 22:31:03 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 22:31:03 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 22:31:05 INFO - Downloading blobuploader-1.2.4.tar.gz 22:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:31:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:31:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:06 INFO - Downloading docopt-0.6.1.tar.gz 22:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:31:06 INFO - Installing collected packages: blobuploader, requests, docopt 22:31:06 INFO - Running setup.py install for blobuploader 22:31:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:31:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:31:06 INFO - Running setup.py install for requests 22:31:06 INFO - Running setup.py install for docopt 22:31:06 INFO - Successfully installed blobuploader requests docopt 22:31:06 INFO - Cleaning up... 22:31:06 INFO - Return code: 0 22:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 22:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 22:31:06 INFO - Using env: {'DISPLAY': ':0', 22:31:06 INFO - 'HOME': '/home/cltbld', 22:31:06 INFO - 'LANG': 'en_US.UTF-8', 22:31:06 INFO - 'LANGUAGE': 'en_US:en', 22:31:06 INFO - 'LOGNAME': 'cltbld', 22:31:06 INFO - 'MAIL': '/var/mail/cltbld', 22:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:06 INFO - 'MOZ_NO_REMOTE': '1', 22:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:06 INFO - 'NO_EM_RESTART': '1', 22:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:06 INFO - 'PWD': '/builds/slave/test', 22:31:06 INFO - 'SHELL': '/bin/bash', 22:31:06 INFO - 'SHLVL': '1', 22:31:06 INFO - 'TERM': 'linux', 22:31:06 INFO - 'TMOUT': '86400', 22:31:06 INFO - 'USER': 'cltbld', 22:31:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:06 INFO - '_': '/tools/buildbot/bin/python'} 22:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:07 INFO - Running setup.py (path:/tmp/pip-bTz4ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:07 INFO - Running setup.py (path:/tmp/pip-k7P2UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:07 INFO - Running setup.py (path:/tmp/pip-FiFOxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:07 INFO - Running setup.py (path:/tmp/pip-6xIbae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:07 INFO - Running setup.py (path:/tmp/pip-_RfmVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:07 INFO - Running setup.py (path:/tmp/pip-36yO79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:07 INFO - Running setup.py (path:/tmp/pip-toekz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:07 INFO - Running setup.py (path:/tmp/pip-x47tAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:07 INFO - Running setup.py (path:/tmp/pip-JgwKwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:07 INFO - Running setup.py (path:/tmp/pip-HCB3bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:07 INFO - Running setup.py (path:/tmp/pip-HtE0wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:07 INFO - Running setup.py (path:/tmp/pip-hivpQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:07 INFO - Running setup.py (path:/tmp/pip-BIb1rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:07 INFO - Running setup.py (path:/tmp/pip-ebqIv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:08 INFO - Running setup.py (path:/tmp/pip-47fPKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:08 INFO - Running setup.py (path:/tmp/pip-bC9yjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:08 INFO - Running setup.py (path:/tmp/pip-vsXreQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:31:08 INFO - Running setup.py install for manifestparser 22:31:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:31:08 INFO - Running setup.py install for mozcrash 22:31:08 INFO - Running setup.py install for mozdebug 22:31:08 INFO - Running setup.py install for mozdevice 22:31:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:31:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:31:08 INFO - Running setup.py install for mozfile 22:31:08 INFO - Running setup.py install for mozhttpd 22:31:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:31:08 INFO - Running setup.py install for mozinfo 22:31:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:31:08 INFO - Running setup.py install for mozInstall 22:31:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Running setup.py install for mozleak 22:31:09 INFO - Running setup.py install for mozlog 22:31:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Running setup.py install for moznetwork 22:31:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Running setup.py install for mozprocess 22:31:09 INFO - Running setup.py install for mozprofile 22:31:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Running setup.py install for mozrunner 22:31:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:31:09 INFO - Running setup.py install for mozscreenshot 22:31:09 INFO - Running setup.py install for moztest 22:31:09 INFO - Running setup.py install for mozversion 22:31:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:31:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:31:10 INFO - Cleaning up... 22:31:10 INFO - Return code: 0 22:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 22:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 22:31:10 INFO - Using env: {'DISPLAY': ':0', 22:31:10 INFO - 'HOME': '/home/cltbld', 22:31:10 INFO - 'LANG': 'en_US.UTF-8', 22:31:10 INFO - 'LANGUAGE': 'en_US:en', 22:31:10 INFO - 'LOGNAME': 'cltbld', 22:31:10 INFO - 'MAIL': '/var/mail/cltbld', 22:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:10 INFO - 'MOZ_NO_REMOTE': '1', 22:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:10 INFO - 'NO_EM_RESTART': '1', 22:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:10 INFO - 'PWD': '/builds/slave/test', 22:31:10 INFO - 'SHELL': '/bin/bash', 22:31:10 INFO - 'SHLVL': '1', 22:31:10 INFO - 'TERM': 'linux', 22:31:10 INFO - 'TMOUT': '86400', 22:31:10 INFO - 'USER': 'cltbld', 22:31:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:10 INFO - '_': '/tools/buildbot/bin/python'} 22:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:10 INFO - Running setup.py (path:/tmp/pip-V9R8H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:10 INFO - Running setup.py (path:/tmp/pip-5tid7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:10 INFO - Running setup.py (path:/tmp/pip-OljJ99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:10 INFO - Running setup.py (path:/tmp/pip-lJ0MSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:10 INFO - Running setup.py (path:/tmp/pip-jKW4vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:10 INFO - Running setup.py (path:/tmp/pip-rtNqG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:10 INFO - Running setup.py (path:/tmp/pip-nNQe9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:10 INFO - Running setup.py (path:/tmp/pip-G92d7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:10 INFO - Running setup.py (path:/tmp/pip-45R5ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:10 INFO - Running setup.py (path:/tmp/pip-_nVlDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:10 INFO - Running setup.py (path:/tmp/pip-v6nDcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:11 INFO - Running setup.py (path:/tmp/pip-XUkbMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:11 INFO - Running setup.py (path:/tmp/pip-06dQzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:11 INFO - Running setup.py (path:/tmp/pip-XA6o3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:11 INFO - Running setup.py (path:/tmp/pip-m7Erpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:11 INFO - Running setup.py (path:/tmp/pip-jk4Yzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:11 INFO - Running setup.py (path:/tmp/pip-pqRXHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:31:11 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 22:31:11 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 22:31:11 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 22:31:11 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 22:31:11 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 22:31:11 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 22:31:13 INFO - Downloading blessings-1.6.tar.gz 22:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:31:13 INFO - Installing collected packages: blessings 22:31:13 INFO - Running setup.py install for blessings 22:31:13 INFO - Successfully installed blessings 22:31:13 INFO - Cleaning up... 22:31:13 INFO - Return code: 0 22:31:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:31:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:13 INFO - Reading from file tmpfile_stdout 22:31:13 INFO - Current package versions: 22:31:13 INFO - argparse == 1.2.1 22:31:13 INFO - blessings == 1.6 22:31:13 INFO - blobuploader == 1.2.4 22:31:13 INFO - docopt == 0.6.1 22:31:13 INFO - functools32 == 3.2.3-2 22:31:13 INFO - jsonschema == 2.5.1 22:31:13 INFO - manifestparser == 1.1 22:31:13 INFO - mozInstall == 1.12 22:31:13 INFO - mozcrash == 0.17 22:31:13 INFO - mozdebug == 0.1 22:31:13 INFO - mozdevice == 0.48 22:31:13 INFO - mozfile == 1.2 22:31:13 INFO - mozhttpd == 0.7 22:31:13 INFO - mozinfo == 0.9 22:31:13 INFO - mozleak == 0.1 22:31:13 INFO - mozlog == 3.2 22:31:13 INFO - moznetwork == 0.27 22:31:13 INFO - mozprocess == 0.22 22:31:13 INFO - mozprofile == 0.28 22:31:13 INFO - mozrunner == 6.11 22:31:13 INFO - mozscreenshot == 0.1 22:31:13 INFO - mozsystemmonitor == 0.3 22:31:13 INFO - moztest == 0.7 22:31:13 INFO - mozversion == 1.4 22:31:13 INFO - psutil == 3.1.1 22:31:13 INFO - requests == 1.2.3 22:31:13 INFO - wsgiref == 0.1.2 22:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 22:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 22:31:13 INFO - Using env: {'DISPLAY': ':0', 22:31:13 INFO - 'HOME': '/home/cltbld', 22:31:13 INFO - 'LANG': 'en_US.UTF-8', 22:31:13 INFO - 'LANGUAGE': 'en_US:en', 22:31:13 INFO - 'LOGNAME': 'cltbld', 22:31:13 INFO - 'MAIL': '/var/mail/cltbld', 22:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:13 INFO - 'MOZ_NO_REMOTE': '1', 22:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:13 INFO - 'NO_EM_RESTART': '1', 22:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:13 INFO - 'PWD': '/builds/slave/test', 22:31:13 INFO - 'SHELL': '/bin/bash', 22:31:13 INFO - 'SHLVL': '1', 22:31:13 INFO - 'TERM': 'linux', 22:31:13 INFO - 'TMOUT': '86400', 22:31:13 INFO - 'USER': 'cltbld', 22:31:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:13 INFO - '_': '/tools/buildbot/bin/python'} 22:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:31:14 INFO - Cleaning up... 22:31:14 INFO - Return code: 0 22:31:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:31:14 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')]} 22:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 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')]} 22:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:31:14 INFO - Running command: ['/builds/slave/test/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/build 22:31:14 INFO - Copy/paste: /builds/slave/test/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 22:31:14 INFO - Using env: {'DISPLAY': ':0', 22:31:14 INFO - 'HOME': '/home/cltbld', 22:31:14 INFO - 'LANG': 'en_US.UTF-8', 22:31:14 INFO - 'LANGUAGE': 'en_US:en', 22:31:14 INFO - 'LOGNAME': 'cltbld', 22:31:14 INFO - 'MAIL': '/var/mail/cltbld', 22:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:14 INFO - 'MOZ_NO_REMOTE': '1', 22:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:14 INFO - 'NO_EM_RESTART': '1', 22:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:14 INFO - 'PWD': '/builds/slave/test', 22:31:14 INFO - 'SHELL': '/bin/bash', 22:31:14 INFO - 'SHLVL': '1', 22:31:14 INFO - 'TERM': 'linux', 22:31:14 INFO - 'TMOUT': '86400', 22:31:14 INFO - 'USER': 'cltbld', 22:31:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:14 INFO - '_': '/tools/buildbot/bin/python'} 22:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:31:14 INFO - Cleaning up... 22:31:14 INFO - Return code: 0 22:31:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:31:14 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')]} 22:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 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')]} 22:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f082e80cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 22:31:14 INFO - Running command: ['/builds/slave/test/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/build 22:31:14 INFO - Copy/paste: /builds/slave/test/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 22:31:14 INFO - Using env: {'DISPLAY': ':0', 22:31:14 INFO - 'HOME': '/home/cltbld', 22:31:14 INFO - 'LANG': 'en_US.UTF-8', 22:31:14 INFO - 'LANGUAGE': 'en_US:en', 22:31:14 INFO - 'LOGNAME': 'cltbld', 22:31:14 INFO - 'MAIL': '/var/mail/cltbld', 22:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:14 INFO - 'MOZ_NO_REMOTE': '1', 22:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:14 INFO - 'NO_EM_RESTART': '1', 22:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:14 INFO - 'PWD': '/builds/slave/test', 22:31:14 INFO - 'SHELL': '/bin/bash', 22:31:14 INFO - 'SHLVL': '1', 22:31:14 INFO - 'TERM': 'linux', 22:31:14 INFO - 'TMOUT': '86400', 22:31:14 INFO - 'USER': 'cltbld', 22:31:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:14 INFO - '_': '/tools/buildbot/bin/python'} 22:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:14 INFO - Downloading/unpacking flake8 22:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:31:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:31:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:31:17 INFO - no previously-included directories found matching 'docs/_build' 22:31:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:31:17 INFO - Running setup.py install for pep8 22:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:31:17 INFO - no previously-included directories found matching 'docs/_build' 22:31:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:31:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:31:17 INFO - Cleaning up... 22:31:17 INFO - Return code: 0 22:31:17 INFO - Running post-action listener: _resource_record_post_action 22:31:17 INFO - Running post-action listener: _start_resource_monitoring 22:31:17 INFO - Starting resource monitoring. 22:31:17 INFO - ##### 22:31:17 INFO - ##### Finished create-virtualenv step (success) 22:31:17 INFO - ##### 22:31:17 INFO - ##### 22:31:17 INFO - ##### Running install step. 22:31:17 INFO - ##### 22:31:17 INFO - Running pre-action listener: _resource_record_pre_action 22:31:17 INFO - Running main action method: install 22:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:17 INFO - Reading from file tmpfile_stdout 22:31:17 INFO - Detecting whether we're running mozinstall >=1.0... 22:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:31:17 INFO - Reading from file tmpfile_stdout 22:31:17 INFO - Output received: 22:31:17 INFO - Usage: mozinstall [options] installer 22:31:17 INFO - Options: 22:31:17 INFO - -h, --help show this help message and exit 22:31:17 INFO - -d DEST, --destination=DEST 22:31:17 INFO - Directory to install application into. [default: 22:31:17 INFO - "/builds/slave/test"] 22:31:17 INFO - --app=APP Application being installed. [default: firefox] 22:31:17 INFO - mkdir: /builds/slave/test/build/application 22:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:31:34 INFO - Reading from file tmpfile_stdout 22:31:34 INFO - Output received: 22:31:34 INFO - /builds/slave/test/build/application/firefox/firefox 22:31:34 INFO - Running post-action listener: _resource_record_post_action 22:31:34 INFO - ##### 22:31:34 INFO - ##### Finished install step (success) 22:31:34 INFO - ##### 22:31:34 INFO - ##### 22:31:34 INFO - ##### Running run-tests step. 22:31:34 INFO - ##### 22:31:34 INFO - Running pre-action listener: _resource_record_pre_action 22:31:34 INFO - Running main action method: run_tests 22:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:31:34 INFO - Python 2.7.3 22:31:34 INFO - Return code: 0 22:31:34 INFO - grabbing minidump binary from tooltool 22:31:34 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')]} 22:31:34 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d536f0>, '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 0x2d545f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d54aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:31:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:31:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:31:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:31:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:31:34 INFO - Return code: 0 22:31:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:31:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:31:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:31:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:31:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:31:35 INFO - Return code: 0 22:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:31:35 INFO - Using env: {'DISPLAY': ':0', 22:31:35 INFO - 'HOME': '/home/cltbld', 22:31:35 INFO - 'LANG': 'en_US.UTF-8', 22:31:35 INFO - 'LANGUAGE': 'en_US:en', 22:31:35 INFO - 'LOGNAME': 'cltbld', 22:31:35 INFO - 'MAIL': '/var/mail/cltbld', 22:31:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:31:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:35 INFO - 'MOZ_NO_REMOTE': '1', 22:31:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:35 INFO - 'NO_EM_RESTART': '1', 22:31:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:35 INFO - 'PWD': '/builds/slave/test', 22:31:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:31:35 INFO - 'SHELL': '/bin/bash', 22:31:35 INFO - 'SHLVL': '1', 22:31:35 INFO - 'TERM': 'linux', 22:31:35 INFO - 'TMOUT': '86400', 22:31:35 INFO - 'USER': 'cltbld', 22:31:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115', 22:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:35 INFO - '_': '/tools/buildbot/bin/python'} 22:31:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:31:35 INFO - mozversion application_buildid: 20160627193059 22:31:35 INFO - mozversion application_changeset: ff3138a7b682cb02dae61c0dca0f327886c57e84 22:31:35 INFO - mozversion application_display_name: Nightly 22:31:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:31:35 INFO - mozversion application_name: Firefox 22:31:35 INFO - mozversion application_remotingname: firefox 22:31:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:31:35 INFO - mozversion application_vendor: Mozilla 22:31:35 INFO - mozversion application_version: 50.0a1 22:31:35 INFO - mozversion platform_buildid: 20160627193059 22:31:35 INFO - mozversion platform_changeset: ff3138a7b682cb02dae61c0dca0f327886c57e84 22:31:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:31:35 INFO - mozversion platform_version: 50.0a1 22:31:35 INFO - using testdate: 1467091895 22:31:35 INFO - actual date: 1467091895 22:31:35 INFO - starting webserver on 'localhost:46014' 22:31:35 INFO - SUITE-START | Running 2 tests 22:31:35 INFO - TEST-START | dromaeo_css 22:31:35 INFO - operating with platform_type : linux_ 22:31:35 INFO - Initialising browser for dromaeo_css test... 22:31:35 INFO - TEST-INFO | started process 10540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprZ0x23/profile http://localhost:46014/getInfo.html) 22:31:40 INFO - PROCESS | 10540 | __metrics Screen width/height:1600/1200 22:31:40 INFO - PROCESS | 10540 | colorDepth:24 22:31:40 INFO - PROCESS | 10540 | Browser inner width/height: 1024/697 22:31:40 INFO - PROCESS | 10540 | __metrics 22:31:41 ERROR - PROCESS | 10540 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:31:42 INFO - TEST-INFO | 10540: exit 0 22:31:42 INFO - Browser initialized. 22:31:42 INFO - Running cycle 1/1 for dromaeo_css test... 22:31:42 INFO - TEST-INFO | started process 10662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprZ0x23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:53 INFO - PROCESS | 10662 | RSS: Main: 167755776 22:31:53 INFO - PROCESS | 10662 | 22:32:43 INFO - PROCESS | 10662 | 1467091963372 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] 22:34:51 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:46014/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46014/tests/dromaeo/cssquery-ext.html) 22:34:52 INFO - PROCESS | 10662 | RSS: Main: 171073536 22:34:52 INFO - PROCESS | 10662 | 22:37:54 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:46014/tests/dromaeo/cssquery-ext.html (next: http://localhost:46014/tests/dromaeo/cssquery-jquery.html) 22:37:55 INFO - PROCESS | 10662 | RSS: Main: 170430464 22:37:55 INFO - PROCESS | 10662 | 22:40:57 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:46014/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46014/tests/dromaeo/cssquery-mootools.html) 22:40:57 INFO - PROCESS | 10662 | RSS: Main: 172388352 22:40:57 INFO - PROCESS | 10662 | 22:43:59 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:46014/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46014/tests/dromaeo/cssquery-prototype.html) 22:44:00 INFO - PROCESS | 10662 | RSS: Main: 169283584 22:44:00 INFO - PROCESS | 10662 | 22:47:02 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:46014/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46014/tests/dromaeo/cssquery-yui.html) 22:47:03 INFO - PROCESS | 10662 | RSS: Main: 171388928 22:47:03 INFO - PROCESS | 10662 | 22:50:05 INFO - PROCESS | 10662 | Cycle 1(1): loaded http://localhost:46014/tests/dromaeo/cssquery-yui.html (next: http://localhost:46014/tests/dromaeo/cssquery-dojo.html) 22:50:06 INFO - PROCESS | 10662 | RSS: Main: 172503040 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | __start_tp_report 22:50:06 INFO - PROCESS | 10662 | _x_x_mozilla_page_load 22:50:06 INFO - PROCESS | 10662 | _x_x_mozilla_page_load_details 22:50:06 INFO - PROCESS | 10662 | |i|pagename|runs| 22:50:06 INFO - PROCESS | 10662 | |0;dojo.html;3128.139761565569;3191.569138166347;3192.8882489112884;3214.871405143794;3224.25842056327;5432.592555558334;5491.780328786844;5516.613837031409;5573.219749235111;5594.608377413582;5363.436839131893;5477.917831232535;5492.80775172869;5505;5629.408912064236;4928.359313289267;4976.253561965698;5063.46833582474;5108.927125303672;5166.43169251382;642.6736642257175;4879.292502587123;4932.482089380599;5072.9746351268195;5081.542661160494;5047.47001564836;5050.090983622947;5051.090803655341;5051.671641343338;5056.84829455117;5097.541221290102;5114.386273647149;5120.334356533664;5126.641135120543;5138.691678499302;4978.751062446863;4990.076835785391;4995.050940321327;5017.949820501784;5071.137906555858;5465.6447330923365;5514.972425137888;5525.4474552544825;5545.694986775726;5593.300837395325;5692.48767610917;5831.125331200312;5948.375420580864;5953.672548009858;5960.105984102376;5938.792142275043;5974;5997.970010149921;5998.520118390518;6013.639181649115;5534.557235421156;5544.667319960815;5548.112302031655;5550.16747487876;5554.72226388683;5908.291005079418;6067.332593414721;6080.2399700037495;6113.57204995646;6115.938840611626;5831.183634291117;5888.558358123158;5893.970530147408;5906.704664766745;5954.642721436728;5955.821325360246;5968.552358573124;5972.074328479092;5990.430909063632;5993.820185394445;5671.716414179275;5805.390434004453;5887.234659494238;5896.292444906553;5921.40785921413;5894.322152952465;5909.409059094056;5911.615744976562;5913.9112913306335;5968.76124954997;4491.73049617024;4509.887252818706;4511.819527218874;4512.481064677604;4522.796474158671;3928.1161738608585;3958.0698535844053;3958.287508248543;3996.86010989614;4030.9395359069636;5544.22380866679;5558.833235002957;5584.855104703526;5601.243832082617;5654.717264136777;5931.851703707442;5975.312839023481;5989.251343582052;5989.670568118795;6008.279006519158;5456;5585.664860108406;5651.943480565224;5655.1517272409465;5657.971710141423;4917.164082106051;4959.454460009396;4975.726335051607;4984.327115839388;5020.874478138003;6157.9384206157365;6171.783987560414;6177.1969643946895;6184.628922264678;6185.690715464209;5749.683767392834;5874.970625146847;5932.49573786233;5945.999999999914;5950.553708471795;6113.694315284129;6116.467104672848;6135.692037377249;6137.907931381123;6157.6613286269685;5838.445347692133;5838.503727183237;5839.474447299764;5852.092925596539;5857.4435428634215;5779.97110014464;5888.440598143169;5922.73347699346;5943.702814859326;5960.344362120077;5727.513161381163;5765.250517432874;5777.711114444345;5788.681622510802;5798.333191682842;5770.567207459373;5806.158107074535;5810.157527158453;5812.128180772918;5823.94176058234;5545.694986775766;5645.181448689999;5668;5710.971445142748;5800.767969281182;5720.942790572208;5803.535717142703;5816.883662326814;5843.211166492469;5854.209681692917;5656.095024796013;5709.628874123168;5728.627639203439;5731.770729170787;5733.39799321082 22:50:06 INFO - PROCESS | 10662 | |1;ext.html;570.7317560746447;608.5253502268232;613.7882430561455;615.2033117113338;637.4167636612501;31112.377752444936;34439.31121377574;41246.793766031165;42525.574744252546;42752.78623606878;43484.56515434845;43542.56457435425;43800.342994855106;43844.342334865;43909;8789.121087891192;8892.15524525169;8971.013188549254;8981.056989016157;8994.595243214071;8779.912200877974;8825.161609647073;8829.867551986725;8851.159139881702;8921.95539022304;8941.552922353889;8969.820603587925;8970;8974.326925480615;9002.189802917736;8816.382853200279;8861.955690221539;8924.375293729441;8932.732018039469;8948.149925757043;8778.385513014091;8828.646854125827;8866.113388661082;8880.777980550538;8901.465912045298;41473.377899331535;41797;41916;41948.1610367794;41973.1605367894;3560.590532088817;3635.6182600826796;3656.1956369598647;3698.519192504984;4146.253674338618;31248.843755781076;32201.83899080513;32259;32324.838375808205;32340.35319293601;4372.781360931973;4400.537943515917;4416.757078360689;4448.644108471314;4557.954420455786;353333;354708;355182;355387;359537.9999999974;33579.83210083983;55701.1644825328;55777.44222557804;56153;56332.43667563354;34501.30997380038;36179.63820361763;36386.63613363833;36412.45381319282;36551.817240913624;14599.343029563695;14629.414823407158;14690.338934747962;14727.116373017654;14786.926065369604;11780.410979450993;11795.764084718428;11835.88164118365;11843.46704398304;11899.762004759856;8251.504909705436;8282.378821588405;8286.83426331482;8334.833303333899;8336.374771892133;3239.5626590409993;3266.281418088017;3266.4283750343593;3271.329377477611;3280.6391296957318;1071.7267096890398;1072.5012869015789;1076.741582020325;1077.6766969908997;1118.6755840806238;32340.67659323424;32437.51343729846;32668;32830.67169328276;33160.50259246113;1124.4827379405565;1141.1156353825852;1166.4575972172981;1167.9357635329968;1243.2097779197927;15965.201739912958;16448.671026579403;16477.34090636385;17461.825381746276;18117.275308987755;526630;530413;536934;539980;861687;57701;58273.417265827644;58699.70650146807;58826;58853.70573147107;1368.2884899852022;1380.6479347766256;1386.4384924105752;1395.5813256023152;1400.285854214358;30658.540121897742;33088.50367244541;33241.66758332482;33248.66751332456;33256.833715831264;50731;51422.22866656928;51448.22827657513;51455.74272128765;51472;503812;508499;514681;515597;516405;27960.762421245843;28231.294217644725;28552.857235713687;28657.570136447554;28840.855795720887;47625;47658.285125723836;47977.28034079422;48593;48889;40125.59874401218;40628.59371406248;41430.585694142675;41696.3745543811;42186;40269;40361.59638403579;40766.184676306904;40804.38793418042;41082;39259.80370098131;39296.60703392929;40013.39979900246;40359.59640403676;40596;33494.497582536766;35841.04572554631;36410;36646.08384790402;36730.8163459181;27254.591181131902;27738.583921240795;27888;28040;28151.57772633453 22:50:06 INFO - PROCESS | 10662 | |2;jquery.html;385.9845606175754;387.62187535627004;388.83085857651923;390.35006713821485;410.66530777416403;18037.36869209578;19587.510312242182;19625.901870490645;19766.11052502637;19847.30534431295;18586.34947776828;18959.336423225155;19443.416697499062;19481.610367792637;19503.609927801437;5548.55611551077;5645.435456454342;5705.51503122233;5707.600467967244;5712.22884910538;5501.312335958005;5588.441155884399;5595.244641973342;5667.0932650775885;5679.7160141992945;5507.091329930557;5566.832995010136;5587.944120558783;5616.354119276274;5655.547556195515;5536.695481748502;5565.6104072714925;5581.134924086732;5587.832365029056;5595.076812325961;5009.599232061463;5034.672746271481;5050.696958182484;5055.342805435306;5066.468020857794;22122.668159977453;22226.777732222632;22854.885725571432;22886.19898303568;23139.53720925572;2386.2244770449674;2433.3551608823677;2505.523950449409;2539.860307683077;2577.6391305217285;14441.78337324941;14512.201828899406;14647.92676036613;14861.777073343908;14870.851291487055;1933.1494142577362;2015.4659015360942;2030.35028790787;2050.8564400491973;2059.1969132038516;59285;70680;75183;78778;81882.77175842426;10345.534450949724;10426.582936682447;10589.84115238272;10635.787284254271;10923.836142457869;14584;14596.854031459761;14649.707005859824;14676.192809395372;14740.410383584536;7611.847763044708;7811.609419529001;7894.763157105296;7915.564643944638;8101.594920253964;7670.923290767021;7707.92292077072;7816.6091695416135;7980.082290536662;8001.239882211181;6563.967180164164;6682.799516014527;6688.398044176048;6712.194536655633;6717.1267735194115;1855.2300795170124;1929.778075521305;1930.855185861066;1949.1131535151471;1982.7719812221778;967.5984466446346;987.9950600247097;1104.309806371018;1147.3574798112916;1161.1465572803982;19869.30457433983;20576.691349629768;20606.17575297001;20779.68830467544;20867.8956605216;977.3012296208103;992.6327258914248;1016.8068067067234;1042.3224903812581;1062.2829590026702;11286.66140015801;11751.588694395827;11849.111316651286;11886.881131188751;11896.22674526153;467350;468045;470827;480721;493669;75281.62359188279;79187;79876;80353.19646803457;80625;996.8056229035413;1000.869886914711;1001.9198464122853;1029.5469993202967;1038.7610849504656;14838.629034273798;16843.494695159166;17943.102844857443;18550.814491854908;18797.436076917715;38971.6102838968;39135.41296880606;39965.40051899282;40133.79933100316;40920.59079409168;49914.25128623146;51421;52486;52496.737516313704;52768.472315276354;7355.77932662021;8870.334724895787;9031.729048128567;9062.365634405529;9276.07239276094;11707.707307317385;13558.796618050934;13677.110987785762;14241.35913883857;14320.856791432368;11968.281903085843;12310.81533777012;12441.191322564366;12446.626601201979;12596;5479.260299859628;9932.652357167464;12031.699207519532;12244.87755122473;12540.87459125397;11705.824412633987;11960.64118076459;12394.194377365442;12650.810237846255;12790.744185116431;7524.811879703051;8113.391495637733;8294.37792165578;8394.11861754507;8741.213290803858;11219.326840389604;12143.75712485763;12365.938170309091;12489.31308778026;12816.359182041047 22:50:06 INFO - PROCESS | 10662 | |3;mootools.html;1459.3505889879002;1461.8684318411345;1573.6537961648432;1709.1795937949792;1716.2620073368446;7769.650365733542;8415.158484151581;8476.576171191447;9148.085191480848;9159.725208243746;8702.390832641702;8759.86860197096;8807.207351338378;8813.647454101829;8828.161324674162;2278.498730279336;2314.143766806284;2318.07277089164;2328.4760928791056;2331.160782118436;2196.8681879087226;2208.5803697297542;2263.818894488437;2263.845438826202;2264.7395549511853;2235.4523141830273;2254.5040091179912;2261.683364328995;2269.387265438331;2280.4754906371545;2187.628103222448;2238.9888050559807;2247.494313779403;2272.784085511874;2274.7611500792427;2236.932892013226;2261.9095236190533;2263.660450932357;2266.875321857297;2266.9886650566805;8901.821963560757;8913.688020919302;8985;9014.414063085878;9068.7279381618;4925.827596034122;5063.772130254148;5094.923576146361;5102.285680004802;5104.846854594331;3103.193169775852;3169.144331030609;3299.637039925606;3327.617324007722;3333.7999720016633;1137.2266858536193;1162.3897453836719;1165.2658824940318;1171.7715045566117;1193.922395044328;12429.75140497185;12460.75078498425;12466.626001219978;12505.06212034101;12512.499500019989;4433.490148632948;4437.445319335083;4571.245744452194;4597.885052873638;4613.123506533748;10240.897591024144;10294.279400441897;10297.794044119075;10323.690289291333;10329;5002.399712034507;5005.649604527721;5008.474110218447;5025.221090730943;5029.5221953914315;4187.664986801049;4525.932111018337;4606.746628935373;4622.838200662961;4753.096911586787;3904.4338570907626;3911.78485183312;4001.339778936443;4043.3126368517424;4046.433499310099;1197.9161458697808;1198.7362780188344;1200.609801814414;1216.5377156680404;1221.151299846598;874.7419511244199;886.1670030171618;905.805251870851;911.1617312072909;928.5960607135918;5764.827055188351;5899.292084949833;5974.522038236931;6048.395160483917;6188.257409110935;932.6409332406937;938.1650331205233;957.9089986451276;960.673371053845;965.2712202287228;3828.73198876076;3956.9909673033194;3964.306246406867;4000.699947503949;4028.093678922219;10740.30188037775;10777.89222107769;11127.944360278309;11129.888701113046;11183.105351572018;11116.166287528467;11132.721681958015;11162;11178.608748693756;11179;8075.798105047304;8125.674973001013;8173.427860049739;8279.37904657141;8318.209770071833;5702.543796496353;5767.567432442667;5852.912206316993;5895.263092113486;5919.141724449844;9242.214411774805;9607.039296070338;10160.136388407069;10253.84619230727;10276.075153236245;9869.210463163074;10074.093331600192;10111.797764044824;10173.389596624227;10174.796504070026;7072.893906591303;7401.370883474965;7692.269234422721;7757.340626046624;7973.601319934096;8588.871166932377;8704.91295087041;8907.73276801697;8921;8925.73222803317;7475.140358858584;7649.579273140031;7708.612449759097;7793.2596403341595;7871.055473343006;7496.7750967471065;7664.923350766644;7711.768646940601;7802.726904558313;7888.6450109744055;7127.786166415016;7140.428765698628;7172.103487064117;7184.425245980414;7192.4246060314;5142.794288228429;5196.168613021899;5251.789928402974;5266.947330526799;5318.308619879391;5247.7113758743635;5339.7063161526485;5375.381831089475;5460.945390546044;5476.561875050066 22:50:06 INFO - PROCESS | 10662 | |4;prototype.html;320.30813442963205;328.46460269760286;331.57227176941745;333.52639252261787;333.8113965609429;5398.541124004464;5583.776648934037;5620.690862002588;5721.656700597967;5735.799247026355;5603.943960560403;5627;5632.211490391349;5633.915491267634;5635.3237611486575;4321.265384884561;4343.869683909487;4376.452943382077;4403.710070763202;4424.6283652067805;4133.23535145999;4374.60628543431;4378.8905277368;4434.334849772527;4447.0661161156195;4308.138372325532;4313.1158112586845;4316.892077698051;4335.913281734363;4338.370936214247;4349.934750978754;4360.23695853226;4363.1273745250755;4374.9219120917305;4414.624756895668;3726.4224045272754;3783.5459744830796;3825.445310429972;3834.2906562286066;3836.5779764225913;5426.294581704393;5429.212764149176;5442.91835622466;5492.258545096401;5514.621344663834;4944.332515110486;4958.851234462972;4996.725180115092;5006.699598024094;5009.574186194178;5767.740451679684;5873.916193998142;5912.645241285493;5914.733836977346;5978.432048955342;4101.985040994867;4119.299719047769;4139.5653456387245;4160.958390416087;4163.8959026024595;6080.844639518477;6127.356627554087;6141.57009009374;6147.938520614826;6167.660778657172;4140.3168477201525;4166.812493437742;4192.601702838226;4209.6000879916355;4300.290452075373;4214.978925105354;4242.8727138185905;4279.550647182001;4323.092150648399;4328.588784065509;4946.604271658259;4972.5027497249985;4980.178270585313;4999.65002449825;5001.299818025406;5691.231683722727;5894.498967587718;5919.644821310735;5945.227120474397;5980.970095149496;1464.2020099046044;1485.042147814675;1490.5826368616804;1491.1500444746391;1495.1851241073641;911.7720569857536;941.6798288581915;945.2674177512346;945.9810803783886;963.797602503468;5021.865707074478;5039.344885164978;5068.797248110034;5087.821926232564;5108.412532558729;5371.6239863209985;5407.45925407464;5492.395836457987;5501.944980550224;5508.834734957877;4842.539958703917;4964.826231081895;5040.974795126001;5073.264376665363;5089.898202035939;2835.489611869842;2876.3096856754228;2895.537753434502;2912.723291287324;2927.6047733556125;5469.304515600176;5471.835844924659;5505.183289514531;5583.525400340935;5651.897879913377;5482.150266708587;5835.299764028344;6342.968285158637;6345.111684364193;6345.460635845912;6382.585131966407;6408.166938297992;6438.452731517874;6450.77422290227;6459.483241340681;5907.261592300963;6073.453389194994;6095.299040610209;6130.356312587114;6169.753209871555;5972.820815375546;6033.909491357545;6042.607230530001;6101.328853826164;6118.051701986199;6052.3658612173585;6134.079888016833;6336.841578960563;6392.584482008655;6396.712147953446;4325.632321252603;4333.631641310524;4363.738175709467;4371.781410929504;4397.340398940057;5988.011978023752;6006.729697163551;6047.848803779764;6101.7559297627595;6116.541259405473;5711.60065783869;5871.647701137946;5886.735096920735;5890.852728681817;5899.911501327398;5831.94168058314;5838.32859221178;5859.648421094748;5882.23530940975;5894.646321220741;5529.972350138223;5778.364379918122;5793.8551536211935;5809.501914176944;5833.8249852502795;5998.6802903361195;6004.639721616717;6010.909836352371;6033.974224381778;6040.305364883095;5850.327212370632;5894.288627231522;5916.230889984447;5933.525317974465;5939.16851640762 22:50:06 INFO - PROCESS | 10662 | |5;yui.html;726.9018682477865;741.9279141640328;788.1173086143518;789.1201310538747;811.8173410982525;14585.416583336668;16274.674506509862;16364.099974501398;16373.75439368409;16381.42665006725;14115.858841411582;14120.858791412084;14130.788038179435;14172.362243699032;14207.857921420782;663.1180529895228;771.0708596141664;778.832551001536;787.940904432167;793.7221972309675;778.17513435758;781.4764108047593;784.7920301120208;786.3669745854585;788.6963519045152;849.3757088539918;850.3367373448689;851.748734123432;852.2840813716477;853.56894768142;840.9243168114868;844.5988155626089;845.0999685335129;845.2350622686479;845.3533047218882;614.1770028162284;616.2081724983419;616.2974209401286;616.7687117331001;618.3291129124905;14647.12117272967;14648.926755366156;14672.70654586913;14708.779368309484;14710.866924295917;15079.773803392958;15199.240037998055;15219.543413697496;15228.695426091415;15280.235988200546;12247.448864801105;12333.444994975247;12383;12423.937880310541;12550.1842380245;3835.668420894958;3880.2864921632936;3882.475865758143;3933.2723446162267;3948.072203032285;72494;72585.63707181482;72711;73277.90083148757;74439.99999999946;10999.61501347449;11040.558377664804;11112.944435277934;11357.432128393548;11379.37413442252;22431.551368972854;23097.307080787603;23115.07539698393;23129;23226.419339516648;8366.58167091643;8376.413651044368;8434.24091831738;8454.281386082252;8543.530105844115;4577.473590537131;4719.95280047202;4822.565969062731;4882.414110306786;4916.041371932439;3299.3566254580605;3478.0783092480515;3483.146629075842;3484.686378225972;3496.30073985204;609.58243603132;632.6299115017766;633.5406830048178;637.5791977294963;637.9298277189505;500.2820951933986;572.287502059938;610.4780412747126;621.2234706616729;669.5915491550151;9422.62309507612;9531.285153613506;9574.377665451724;9656.468894210746;9949;626.2578844069701;658.96375699337;661.4047357378302;689.5173378634976;695.1380288442296;4476.37330773692;4515.88710282239;4541.727496350163;4557.680962332671;4633.976830115827;117086;118068;119590;123591.38204309101;124088.37955810163;99005.50497247612;103115;103394;103845;104288;87853;88101.95184385234;88206;88671;89061;9774.511274436392;9923.156531694887;10064.798704026025;10319.432431216355;10603.681889543326;48552;50352.24471633002;51227.743861281946;51715;53346.1998070037;69653.30346696469;74722.25277747153;75168;75675;76215.61892190503;12901;12937.611871643488;12944.15862968904;13102.541411050568;13203.078153108443;14027.437628178439;14154.292285385896;14255.358508866919;14512.927435362755;14828.777568336267;13155.144915580457;13492.460301587827;13749.587512374645;13845.584632461043;14174.716505670036;13168.60494185176;13506.189628622315;13678.316084195949;13875.306234688427;14478.27608619586;12729.745405092031;13250.801237981244;13345.799813002619;13506.189628622315;14224.857751422353;10969.149885923953;11480.253783504046;11482.598109066143;11623.59317423886;11803.704907377385;9751.804963900824;9852.241322544944;9953.104220620178;9979.351342162736;10017.198624110199 22:50:06 INFO - PROCESS | 10662 | __end_tp_report 22:50:06 INFO - PROCESS | 10662 | __start_cc_report 22:50:06 INFO - PROCESS | 10662 | _x_x_mozilla_cycle_collect,358 22:50:06 INFO - PROCESS | 10662 | __end_cc_report 22:50:06 INFO - PROCESS | 10662 | __startTimestamp1467093006052__endTimestamp 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | ------- Summary: start ------- 22:50:06 INFO - PROCESS | 10662 | Number of tests: 6 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | [#0] dojo.html Cycles:165 Average:5470.20 Median:5720.94 stddev:739.34 (12.9%) stddev-sans-first:718.42 22:50:06 INFO - PROCESS | 10662 | Values: 3128.1 3191.6 3192.9 3214.9 3224.3 5432.6 5491.8 5516.6 5573.2 5594.6 5363.4 5477.9 5492.8 5505.0 5629.4 4928.4 4976.3 5063.5 5108.9 5166.4 642.7 4879.3 4932.5 5073.0 5081.5 5047.5 5050.1 5051.1 5051.7 5056.8 5097.5 5114.4 5120.3 5126.6 5138.7 4978.8 4990.1 4995.1 5017.9 5071.1 5465.6 5515.0 5525.4 5545.7 5593.3 5692.5 5831.1 5948.4 5953.7 5960.1 5938.8 5974.0 5998.0 5998.5 6013.6 5534.6 5544.7 5548.1 5550.2 5554.7 5908.3 6067.3 6080.2 6113.6 6115.9 5831.2 5888.6 5894.0 5906.7 5954.6 5955.8 5968.6 5972.1 5990.4 5993.8 5671.7 5805.4 5887.2 5896.3 5921.4 5894.3 5909.4 5911.6 5913.9 5968.8 4491.7 4509.9 4511.8 4512.5 4522.8 3928.1 3958.1 3958.3 3996.9 4030.9 5544.2 5558.8 5584.9 5601.2 5654.7 5931.9 5975.3 5989.3 5989.7 6008.3 5456.0 5585.7 5651.9 5655.2 5658.0 4917.2 4959.5 4975.7 4984.3 5020.9 6157.9 6171.8 6177.2 6184.6 6185.7 5749.7 5875.0 5932.5 5946.0 5950.6 6113.7 6116.5 6135.7 6137.9 6157.7 5838.4 5838.5 5839.5 5852.1 5857.4 5780.0 5888.4 5922.7 5943.7 5960.3 5727.5 5765.3 5777.7 5788.7 5798.3 5770.6 5806.2 5810.2 5812.1 5823.9 5545.7 5645.2 5668.0 5711.0 5800.8 5720.9 5803.5 5816.9 5843.2 5854.2 5656.1 5709.6 5728.6 5731.8 5733.4 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | [#1] ext.html Cycles:180 Average:62754.51 Median:40697.39 stddev:135012.19 (331.7%) stddev-sans-first:135310.21 22:50:06 INFO - PROCESS | 10662 | Values: 570.7 608.5 613.8 615.2 637.4 31112.4 34439.3 41246.8 42525.6 42752.8 43484.6 43542.6 43800.3 43844.3 43909.0 8789.1 8892.2 8971.0 8981.1 8994.6 8779.9 8825.2 8829.9 8851.2 8922.0 8941.6 8969.8 8970.0 8974.3 9002.2 8816.4 8862.0 8924.4 8932.7 8948.1 8778.4 8828.6 8866.1 8880.8 8901.5 41473.4 41797.0 41916.0 41948.2 41973.2 3560.6 3635.6 3656.2 3698.5 4146.3 31248.8 32201.8 32259.0 32324.8 32340.4 4372.8 4400.5 4416.8 4448.6 4558.0 353333.0 354708.0 355182.0 355387.0 359538.0 33579.8 55701.2 55777.4 56153.0 56332.4 34501.3 36179.6 36386.6 36412.5 36551.8 14599.3 14629.4 14690.3 14727.1 14786.9 11780.4 11795.8 11835.9 11843.5 11899.8 8251.5 8282.4 8286.8 8334.8 8336.4 3239.6 3266.3 3266.4 3271.3 3280.6 1071.7 1072.5 1076.7 1077.7 1118.7 32340.7 32437.5 32668.0 32830.7 33160.5 1124.5 1141.1 1166.5 1167.9 1243.2 15965.2 16448.7 16477.3 17461.8 18117.3 526630.0 530413.0 536934.0 539980.0 861687.0 57701.0 58273.4 58699.7 58826.0 58853.7 1368.3 1380.6 1386.4 1395.6 1400.3 30658.5 33088.5 33241.7 33248.7 33256.8 50731.0 51422.2 51448.2 51455.7 51472.0 503812.0 508499.0 514681.0 515597.0 516405.0 27960.8 28231.3 28552.9 28657.6 28840.9 47625.0 47658.3 47977.3 48593.0 48889.0 40125.6 40628.6 41430.6 41696.4 42186.0 40269.0 40361.6 40766.2 40804.4 41082.0 39259.8 39296.6 40013.4 40359.6 40596.0 33494.5 35841.0 36410.0 36646.1 36730.8 27254.6 27738.6 27888.0 28040.0 28151.6 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | [#2] jquery.html Cycles:180 Average:28008.26 Median:2522.69 stddev:78104.48 (3096.1%) stddev-sans-first:78296.04 22:50:06 INFO - PROCESS | 10662 | Values: 386.0 387.6 388.8 390.4 410.7 18037.4 19587.5 19625.9 19766.1 19847.3 18586.3 18959.3 19443.4 19481.6 19503.6 5548.6 5645.4 5705.5 5707.6 5712.2 5501.3 5588.4 5595.2 5667.1 5679.7 5507.1 5566.8 5587.9 5616.4 5655.5 5536.7 5565.6 5581.1 5587.8 5595.1 5009.6 5034.7 5050.7 5055.3 5066.5 22122.7 22226.8 22854.9 22886.2 23139.5 2386.2 2433.4 2505.5 2539.9 2577.6 14441.8 14512.2 14647.9 14861.8 14870.9 1933.1 2015.5 2030.4 2050.9 2059.2 59285.0 70680.0 75183.0 78778.0 81882.8 10345.5 10426.6 10589.8 10635.8 10923.8 14584.0 14596.9 14649.7 14676.2 14740.4 7611.8 7811.6 7894.8 7915.6 8101.6 7670.9 7707.9 7816.6 7980.1 8001.2 6564.0 6682.8 6688.4 6712.2 6717.1 1855.2 1929.8 1930.9 1949.1 1982.8 967.6 988.0 1104.3 1147.4 1161.1 19869.3 20576.7 20606.2 20779.7 20867.9 977.3 992.6 1016.8 1042.3 1062.3 11286.7 11751.6 11849.1 11886.9 11896.2 467350.0 468045.0 470827.0 480721.0 493669.0 75281.6 79187.0 79876.0 80353.2 80625.0 996.8 1000.9 1001.9 1029.5 1038.8 14838.6 16843.5 17943.1 18550.8 18797.4 38971.6 39135.4 39965.4 40133.8 40920.6 49914.3 51421.0 52486.0 52496.7 52768.5 7355.8 8870.3 9031.7 9062.4 9276.1 11707.7 13558.8 13677.1 14241.4 14320.9 11968.3 12310.8 12441.2 12446.6 12596.0 5479.3 9932.7 12031.7 12244.9 12540.9 11705.8 11960.6 12394.2 12650.8 12790.7 7524.8 8113.4 8294.4 8394.1 8741.2 11219.3 12143.8 12365.9 12489.3 12816.4 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | [#3] mootools.html Cycles:180 Average:5785.82 Median:4687.97 stddev:3337.43 (71.2%) stddev-sans-first:3330.95 22:50:06 INFO - PROCESS | 10662 | Values: 1459.4 1461.9 1573.7 1709.2 1716.3 7769.7 8415.2 8476.6 9148.1 9159.7 8702.4 8759.9 8807.2 8813.6 8828.2 2278.5 2314.1 2318.1 2328.5 2331.2 2196.9 2208.6 2263.8 2263.8 2264.7 2235.5 2254.5 2261.7 2269.4 2280.5 2187.6 2239.0 2247.5 2272.8 2274.8 2236.9 2261.9 2263.7 2266.9 2267.0 8901.8 8913.7 8985.0 9014.4 9068.7 4925.8 5063.8 5094.9 5102.3 5104.8 3103.2 3169.1 3299.6 3327.6 3333.8 1137.2 1162.4 1165.3 1171.8 1193.9 12429.8 12460.8 12466.6 12505.1 12512.5 4433.5 4437.4 4571.2 4597.9 4613.1 10240.9 10294.3 10297.8 10323.7 10329.0 5002.4 5005.6 5008.5 5025.2 5029.5 4187.7 4525.9 4606.7 4622.8 4753.1 3904.4 3911.8 4001.3 4043.3 4046.4 1197.9 1198.7 1200.6 1216.5 1221.2 874.7 886.2 905.8 911.2 928.6 5764.8 5899.3 5974.5 6048.4 6188.3 932.6 938.2 957.9 960.7 965.3 3828.7 3957.0 3964.3 4000.7 4028.1 10740.3 10777.9 11127.9 11129.9 11183.1 11116.2 11132.7 11162.0 11178.6 11179.0 8075.8 8125.7 8173.4 8279.4 8318.2 5702.5 5767.6 5852.9 5895.3 5919.1 9242.2 9607.0 10160.1 10253.8 10276.1 9869.2 10074.1 10111.8 10173.4 10174.8 7072.9 7401.4 7692.3 7757.3 7973.6 8588.9 8704.9 8907.7 8921.0 8925.7 7475.1 7649.6 7708.6 7793.3 7871.1 7496.8 7664.9 7711.8 7802.7 7888.6 7127.8 7140.4 7172.1 7184.4 7192.4 5142.8 5196.2 5251.8 5266.9 5318.3 5247.7 5339.7 5375.4 5460.9 5476.6 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | [#4] prototype.html Cycles:180 Average:4883.50 Median:5497.17 stddev:1463.24 (26.6%) stddev-sans-first:1426.70 22:50:06 INFO - PROCESS | 10662 | Values: 320.3 328.5 331.6 333.5 333.8 5398.5 5583.8 5620.7 5721.7 5735.8 5603.9 5627.0 5632.2 5633.9 5635.3 4321.3 4343.9 4376.5 4403.7 4424.6 4133.2 4374.6 4378.9 4434.3 4447.1 4308.1 4313.1 4316.9 4335.9 4338.4 4349.9 4360.2 4363.1 4374.9 4414.6 3726.4 3783.5 3825.4 3834.3 3836.6 5426.3 5429.2 5442.9 5492.3 5514.6 4944.3 4958.9 4996.7 5006.7 5009.6 5767.7 5873.9 5912.6 5914.7 5978.4 4102.0 4119.3 4139.6 4161.0 4163.9 6080.8 6127.4 6141.6 6147.9 6167.7 4140.3 4166.8 4192.6 4209.6 4300.3 4215.0 4242.9 4279.6 4323.1 4328.6 4946.6 4972.5 4980.2 4999.7 5001.3 5691.2 5894.5 5919.6 5945.2 5981.0 1464.2 1485.0 1490.6 1491.2 1495.2 911.8 941.7 945.3 946.0 963.8 5021.9 5039.3 5068.8 5087.8 5108.4 5371.6 5407.5 5492.4 5501.9 5508.8 4842.5 4964.8 5041.0 5073.3 5089.9 2835.5 2876.3 2895.5 2912.7 2927.6 5469.3 5471.8 5505.2 5583.5 5651.9 5482.2 5835.3 6343.0 6345.1 6345.5 6382.6 6408.2 6438.5 6450.8 6459.5 5907.3 6073.5 6095.3 6130.4 6169.8 5972.8 6033.9 6042.6 6101.3 6118.1 6052.4 6134.1 6336.8 6392.6 6396.7 4325.6 4333.6 4363.7 4371.8 4397.3 5988.0 6006.7 6047.8 6101.8 6116.5 5711.6 5871.6 5886.7 5890.9 5899.9 5831.9 5838.3 5859.6 5882.2 5894.6 5530.0 5778.4 5793.9 5809.5 5833.8 5998.7 6004.6 6010.9 6034.0 6040.3 5850.3 5894.3 5916.2 5933.5 5939.2 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - PROCESS | 10662 | [#5] yui.html Cycles:180 Average:21044.23 Median:4549.70 stddev:30654.18 (673.8%) stddev-sans-first:30702.21 22:50:06 INFO - PROCESS | 10662 | Values: 726.9 741.9 788.1 789.1 811.8 14585.4 16274.7 16364.1 16373.8 16381.4 14115.9 14120.9 14130.8 14172.4 14207.9 663.1 771.1 778.8 787.9 793.7 778.2 781.5 784.8 786.4 788.7 849.4 850.3 851.7 852.3 853.6 840.9 844.6 845.1 845.2 845.4 614.2 616.2 616.3 616.8 618.3 14647.1 14648.9 14672.7 14708.8 14710.9 15079.8 15199.2 15219.5 15228.7 15280.2 12247.4 12333.4 12383.0 12423.9 12550.2 3835.7 3880.3 3882.5 3933.3 3948.1 72494.0 72585.6 72711.0 73277.9 74440.0 10999.6 11040.6 11112.9 11357.4 11379.4 22431.6 23097.3 23115.1 23129.0 23226.4 8366.6 8376.4 8434.2 8454.3 8543.5 4577.5 4720.0 4822.6 4882.4 4916.0 3299.4 3478.1 3483.1 3484.7 3496.3 609.6 632.6 633.5 637.6 637.9 500.3 572.3 610.5 621.2 669.6 9422.6 9531.3 9574.4 9656.5 9949.0 626.3 659.0 661.4 689.5 695.1 4476.4 4515.9 4541.7 4557.7 4634.0 117086.0 118068.0 119590.0 123591.4 124088.4 99005.5 103115.0 103394.0 103845.0 104288.0 87853.0 88102.0 88206.0 88671.0 89061.0 9774.5 9923.2 10064.8 10319.4 10603.7 48552.0 50352.2 51227.7 51715.0 53346.2 69653.3 74722.3 75168.0 75675.0 76215.6 12901.0 12937.6 12944.2 13102.5 13203.1 14027.4 14154.3 14255.4 14512.9 14828.8 13155.1 13492.5 13749.6 13845.6 14174.7 13168.6 13506.2 13678.3 13875.3 14478.3 12729.7 13250.8 13345.8 13506.2 14224.9 10969.1 11480.3 11482.6 11623.6 11803.7 9751.8 9852.2 9953.1 9979.4 10017.2 22:50:06 INFO - PROCESS | 10662 | -------- Summary: end -------- 22:50:06 INFO - PROCESS | 10662 | 22:50:06 INFO - TEST-INFO | 10662: exit 0 22:50:06 INFO - TEST-OK | dromaeo_css | took 1110795ms 22:50:06 INFO - TEST-START | kraken 22:50:06 INFO - operating with platform_type : linux_ 22:50:06 INFO - Initialising browser for kraken test... 22:50:06 INFO - TEST-INFO | started process 10902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgXSJQO/profile http://localhost:46014/getInfo.html) 22:50:11 INFO - PROCESS | 10902 | __metrics Screen width/height:1600/1200 22:50:11 INFO - PROCESS | 10902 | colorDepth:24 22:50:11 INFO - PROCESS | 10902 | Browser inner width/height: 1024/697 22:50:11 INFO - PROCESS | 10902 | __metrics 22:50:11 ERROR - PROCESS | 10902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:50:12 INFO - TEST-INFO | 10902: exit 0 22:50:12 INFO - Browser initialized. 22:50:12 INFO - Running cycle 1/1 for kraken test... 22:50:12 INFO - TEST-INFO | started process 11024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgXSJQO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:50:24 INFO - PROCESS | 11024 | RSS: Main: 168300544 22:50:24 INFO - PROCESS | 11024 | 22:50:26 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46014/tests/kraken/driver.html?testName=audio-beat-detection) 22:50:27 INFO - PROCESS | 11024 | RSS: Main: 173772800 22:50:27 INFO - PROCESS | 11024 | 22:50:30 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46014/tests/kraken/driver.html?testName=audio-dft) 22:50:31 INFO - PROCESS | 11024 | RSS: Main: 172777472 22:50:31 INFO - PROCESS | 11024 | 22:50:33 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46014/tests/kraken/driver.html?testName=audio-fft) 22:50:34 INFO - PROCESS | 11024 | RSS: Main: 167608320 22:50:34 INFO - PROCESS | 11024 | 22:50:36 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46014/tests/kraken/driver.html?testName=audio-oscillator) 22:50:37 INFO - PROCESS | 11024 | RSS: Main: 169025536 22:50:37 INFO - PROCESS | 11024 | 22:50:39 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46014/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:50:40 INFO - PROCESS | 11024 | RSS: Main: 168681472 22:50:40 INFO - PROCESS | 11024 | 22:50:43 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46014/tests/kraken/driver.html?testName=imaging-darkroom) 22:50:43 INFO - PROCESS | 11024 | RSS: Main: 168996864 22:50:43 INFO - PROCESS | 11024 | 22:50:47 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46014/tests/kraken/driver.html?testName=imaging-desaturate) 22:50:47 INFO - PROCESS | 11024 | RSS: Main: 169619456 22:50:47 INFO - PROCESS | 11024 | 22:50:50 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46014/tests/kraken/driver.html?testName=json-parse-financial) 22:50:51 INFO - PROCESS | 11024 | RSS: Main: 169324544 22:50:51 INFO - PROCESS | 11024 | 22:50:52 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46014/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:50:53 INFO - PROCESS | 11024 | RSS: Main: 169582592 22:50:53 INFO - PROCESS | 11024 | 22:50:55 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:50:56 INFO - PROCESS | 11024 | RSS: Main: 169762816 22:50:56 INFO - PROCESS | 11024 | 22:50:58 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:50:58 INFO - PROCESS | 11024 | RSS: Main: 169811968 22:50:58 INFO - PROCESS | 11024 | 22:51:01 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:51:02 INFO - PROCESS | 11024 | RSS: Main: 170151936 22:51:02 INFO - PROCESS | 11024 | 22:51:04 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:51:05 INFO - PROCESS | 11024 | RSS: Main: 169852928 22:51:05 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | Cycle 1(1): loaded http://localhost:46014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46014/tests/kraken/driver.html?testName=ai-astar) 22:51:07 INFO - PROCESS | 11024 | RSS: Main: 170713088 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | __start_tp_report 22:51:07 INFO - PROCESS | 11024 | _x_x_mozilla_page_load 22:51:07 INFO - PROCESS | 11024 | _x_x_mozilla_page_load_details 22:51:07 INFO - PROCESS | 11024 | |i|pagename|runs| 22:51:07 INFO - PROCESS | 11024 | |0;ai-astar;102;110;103;109;111;110;112;110;110;110 22:51:07 INFO - PROCESS | 11024 | |1;audio-beat-detection;164;127;157;194;128;164;160;136;189;134 22:51:07 INFO - PROCESS | 11024 | |2;audio-dft;160;164;161;161;161;167;177;164;163;162 22:51:07 INFO - PROCESS | 11024 | |3;audio-fft;74;80;76;157;76;75;76;75;163;78 22:51:07 INFO - PROCESS | 11024 | |4;audio-oscillator;85;87;156;86;86;85;138;85;89;136 22:51:07 INFO - PROCESS | 11024 | |5;imaging-gaussian-blur;118;118;118;118;117;118;117;117;118;118 22:51:07 INFO - PROCESS | 11024 | |6;imaging-darkroom;146;148;147;147;147;147;148;147;147;147 22:51:07 INFO - PROCESS | 11024 | |7;imaging-desaturate;96;97;95;95;96;96;95;96;95;96 22:51:07 INFO - PROCESS | 11024 | |8;json-parse-financial;55;56;59;56;58;55;56;59;56;56 22:51:07 INFO - PROCESS | 11024 | |9;json-stringify-tinderbox;62;61;61;62;62;61;62;62;64;62 22:51:07 INFO - PROCESS | 11024 | |10;stanford-crypto-aes;85;81;79;84;80;80;82;83;128;78 22:51:07 INFO - PROCESS | 11024 | |11;stanford-crypto-ccm;126;128;123;121;120;121;134;133;132;122 22:51:07 INFO - PROCESS | 11024 | |12;stanford-crypto-pbkdf2;160;157;157;161;156;159;159;161;175;167 22:51:07 INFO - PROCESS | 11024 | |13;stanford-crypto-sha256-iterative;63;66;63;63;65;63;68;62;64;62 22:51:07 INFO - PROCESS | 11024 | __end_tp_report 22:51:07 INFO - PROCESS | 11024 | __start_cc_report 22:51:07 INFO - PROCESS | 11024 | _x_x_mozilla_cycle_collect,906 22:51:07 INFO - PROCESS | 11024 | __end_cc_report 22:51:07 INFO - PROCESS | 11024 | __startTimestamp1467093067255__endTimestamp 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | ------- Summary: start ------- 22:51:07 INFO - PROCESS | 11024 | Number of tests: 14 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:2.55 22:51:07 INFO - PROCESS | 11024 | Values: 102.0 110.0 103.0 109.0 111.0 110.0 112.0 110.0 110.0 110.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:162.00 stddev:24.00 (14.8%) stddev-sans-first:25.24 22:51:07 INFO - PROCESS | 11024 | Values: 164.0 127.0 157.0 194.0 128.0 164.0 160.0 136.0 189.0 134.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:5.01 (3.1%) stddev-sans-first:5.10 22:51:07 INFO - PROCESS | 11024 | Values: 160.0 164.0 161.0 161.0 161.0 167.0 177.0 164.0 163.0 162.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:35.38 (46.6%) stddev-sans-first:36.85 22:51:07 INFO - PROCESS | 11024 | Values: 74.0 80.0 76.0 157.0 76.0 75.0 76.0 75.0 163.0 78.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:85.50 stddev:28.13 (32.9%) stddev-sans-first:29.05 22:51:07 INFO - PROCESS | 11024 | Values: 85.0 87.0 156.0 86.0 86.0 85.0 138.0 85.0 89.0 136.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:51:07 INFO - PROCESS | 11024 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 22:51:07 INFO - PROCESS | 11024 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:51:07 INFO - PROCESS | 11024 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.48 22:51:07 INFO - PROCESS | 11024 | Values: 55.0 56.0 59.0 56.0 58.0 55.0 56.0 59.0 56.0 56.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 22:51:07 INFO - PROCESS | 11024 | Values: 62.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 64.0 62.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:81.50 stddev:14.92 (18.3%) stddev-sans-first:15.82 22:51:07 INFO - PROCESS | 11024 | Values: 85.0 81.0 79.0 84.0 80.0 80.0 82.0 83.0 128.0 78.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.00 stddev:5.42 (4.3%) stddev-sans-first:5.74 22:51:07 INFO - PROCESS | 11024 | Values: 126.0 128.0 123.0 121.0 120.0 121.0 134.0 133.0 132.0 122.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:160.50 stddev:5.75 (3.6%) stddev-sans-first:6.08 22:51:07 INFO - PROCESS | 11024 | Values: 160.0 157.0 157.0 161.0 156.0 159.0 159.0 161.0 175.0 167.0 22:51:07 INFO - PROCESS | 11024 | 22:51:07 INFO - PROCESS | 11024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:1.91 (3.0%) stddev-sans-first:2.00 22:51:07 INFO - PROCESS | 11024 | Values: 63.0 66.0 63.0 63.0 65.0 63.0 68.0 62.0 64.0 62.0 22:51:07 INFO - PROCESS | 11024 | -------- Summary: end -------- 22:51:07 INFO - PROCESS | 11024 | 22:51:08 INFO - TEST-INFO | 11024: exit 0 22:51:08 INFO - TEST-OK | kraken | took 61464ms 22:51:08 INFO - SUITE-END | took 1172s 22:51:08 INFO - Completed test suite (00:19:32) 22:51:08 INFO - javascript benchmark 22:51:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7254.88973908607, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.139761565569, 3191.569138166347, 3192.8882489112884, 3214.871405143794, 3224.25842056327, 5432.592555558334, 5491.780328786844, 5516.613837031409, 5573.219749235111, 5594.608377413582, 5363.436839131893, 5477.917831232535, 5492.80775172869, 5505.0, 5629.408912064236, 4928.359313289267, 4976.253561965698, 5063.46833582474, 5108.927125303672, 5166.43169251382, 642.6736642257175, 4879.292502587123, 4932.482089380599, 5072.9746351268195, 5081.542661160494, 5047.47001564836, 5050.090983622947, 5051.090803655341, 5051.671641343338, 5056.84829455117, 5097.541221290102, 5114.386273647149, 5120.334356533664, 5126.641135120543, 5138.691678499302, 4978.751062446863, 4990.076835785391, 4995.050940321327, 5017.949820501784, 5071.137906555858, 5465.6447330923365, 5514.972425137888, 5525.4474552544825, 5545.694986775726, 5593.300837395325, 5692.48767610917, 5831.125331200312, 5948.375420580864, 5953.672548009858, 5960.105984102376, 5938.792142275043, 5974.0, 5997.970010149921, 5998.520118390518, 6013.639181649115, 5534.557235421156, 5544.667319960815, 5548.112302031655, 5550.16747487876, 5554.72226388683, 5908.291005079418, 6067.332593414721, 6080.2399700037495, 6113.57204995646, 6115.938840611626, 5831.183634291117, 5888.558358123158, 5893.970530147408, 5906.704664766745, 5954.642721436728, 5955.821325360246, 5968.552358573124, 5972.074328479092, 5990.430909063632, 5993.820185394445, 5671.716414179275, 5805.390434004453, 5887.234659494238, 5896.292444906553, 5921.40785921413, 5894.322152952465, 5909.409059094056, 5911.615744976562, 5913.9112913306335, 5968.76124954997, 4491.73049617024, 4509.887252818706, 4511.819527218874, 4512.481064677604, 4522.796474158671, 3928.1161738608585, 3958.0698535844053, 3958.287508248543, 3996.86010989614, 4030.9395359069636, 5544.22380866679, 5558.833235002957, 5584.855104703526, 5601.243832082617, 5654.717264136777, 5931.851703707442, 5975.312839023481, 5989.251343582052, 5989.670568118795, 6008.279006519158, 5456.0, 5585.664860108406, 5651.943480565224, 5655.1517272409465, 5657.971710141423, 4917.164082106051, 4959.454460009396, 4975.726335051607, 4984.327115839388, 5020.874478138003, 6157.9384206157365, 6171.783987560414, 6177.1969643946895, 6184.628922264678, 6185.690715464209, 5749.683767392834, 5874.970625146847, 5932.49573786233, 5945.999999999914, 5950.553708471795, 6113.694315284129, 6116.467104672848, 6135.692037377249, 6137.907931381123, 6157.6613286269685, 5838.445347692133, 5838.503727183237, 5839.474447299764, 5852.092925596539, 5857.4435428634215, 5779.97110014464, 5888.440598143169, 5922.73347699346, 5943.702814859326, 5960.344362120077, 5727.513161381163, 5765.250517432874, 5777.711114444345, 5788.681622510802, 5798.333191682842, 5770.567207459373, 5806.158107074535, 5810.157527158453, 5812.128180772918, 5823.94176058234, 5545.694986775766, 5645.181448689999, 5668.0, 5710.971445142748, 5800.767969281182, 5720.942790572208, 5803.535717142703, 5816.883662326814, 5843.211166492469, 5854.209681692917, 5656.095024796013, 5709.628874123168, 5728.627639203439, 5731.770729170787, 5733.39799321082], "value": 5421.148591178656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7317560746447, 608.5253502268232, 613.7882430561455, 615.2033117113338, 637.4167636612501, 31112.377752444936, 34439.31121377574, 41246.793766031165, 42525.574744252546, 42752.78623606878, 43484.56515434845, 43542.56457435425, 43800.342994855106, 43844.342334865, 43909.0, 8789.121087891192, 8892.15524525169, 8971.013188549254, 8981.056989016157, 8994.595243214071, 8779.912200877974, 8825.161609647073, 8829.867551986725, 8851.159139881702, 8921.95539022304, 8941.552922353889, 8969.820603587925, 8970.0, 8974.326925480615, 9002.189802917736, 8816.382853200279, 8861.955690221539, 8924.375293729441, 8932.732018039469, 8948.149925757043, 8778.385513014091, 8828.646854125827, 8866.113388661082, 8880.777980550538, 8901.465912045298, 41473.377899331535, 41797.0, 41916.0, 41948.1610367794, 41973.1605367894, 3560.590532088817, 3635.6182600826796, 3656.1956369598647, 3698.519192504984, 4146.253674338618, 31248.843755781076, 32201.83899080513, 32259.0, 32324.838375808205, 32340.35319293601, 4372.781360931973, 4400.537943515917, 4416.757078360689, 4448.644108471314, 4557.954420455786, 353333.0, 354708.0, 355182.0, 355387.0, 359537.9999999974, 33579.83210083983, 55701.1644825328, 55777.44222557804, 56153.0, 56332.43667563354, 34501.30997380038, 36179.63820361763, 36386.63613363833, 36412.45381319282, 36551.817240913624, 14599.343029563695, 14629.414823407158, 14690.338934747962, 14727.116373017654, 14786.926065369604, 11780.410979450993, 11795.764084718428, 11835.88164118365, 11843.46704398304, 11899.762004759856, 8251.504909705436, 8282.378821588405, 8286.83426331482, 8334.833303333899, 8336.374771892133, 3239.5626590409993, 3266.281418088017, 3266.4283750343593, 3271.329377477611, 3280.6391296957318, 1071.7267096890398, 1072.5012869015789, 1076.741582020325, 1077.6766969908997, 1118.6755840806238, 32340.67659323424, 32437.51343729846, 32668.0, 32830.67169328276, 33160.50259246113, 1124.4827379405565, 1141.1156353825852, 1166.4575972172981, 1167.9357635329968, 1243.2097779197927, 15965.201739912958, 16448.671026579403, 16477.34090636385, 17461.825381746276, 18117.275308987755, 526630.0, 530413.0, 536934.0, 539980.0, 861687.0, 57701.0, 58273.417265827644, 58699.70650146807, 58826.0, 58853.70573147107, 1368.2884899852022, 1380.6479347766256, 1386.4384924105752, 1395.5813256023152, 1400.285854214358, 30658.540121897742, 33088.50367244541, 33241.66758332482, 33248.66751332456, 33256.833715831264, 50731.0, 51422.22866656928, 51448.22827657513, 51455.74272128765, 51472.0, 503812.0, 508499.0, 514681.0, 515597.0, 516405.0, 27960.762421245843, 28231.294217644725, 28552.857235713687, 28657.570136447554, 28840.855795720887, 47625.0, 47658.285125723836, 47977.28034079422, 48593.0, 48889.0, 40125.59874401218, 40628.59371406248, 41430.585694142675, 41696.3745543811, 42186.0, 40269.0, 40361.59638403579, 40766.184676306904, 40804.38793418042, 41082.0, 39259.80370098131, 39296.60703392929, 40013.39979900246, 40359.59640403676, 40596.0, 33494.497582536766, 35841.04572554631, 36410.0, 36646.08384790402, 36730.8163459181, 27254.591181131902, 27738.583921240795, 27888.0, 28040.0, 28151.57772633453], "value": 18985.00114210214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.9845606175754, 387.62187535627004, 388.83085857651923, 390.35006713821485, 410.66530777416403, 18037.36869209578, 19587.510312242182, 19625.901870490645, 19766.11052502637, 19847.30534431295, 18586.34947776828, 18959.336423225155, 19443.416697499062, 19481.610367792637, 19503.609927801437, 5548.55611551077, 5645.435456454342, 5705.51503122233, 5707.600467967244, 5712.22884910538, 5501.312335958005, 5588.441155884399, 5595.244641973342, 5667.0932650775885, 5679.7160141992945, 5507.091329930557, 5566.832995010136, 5587.944120558783, 5616.354119276274, 5655.547556195515, 5536.695481748502, 5565.6104072714925, 5581.134924086732, 5587.832365029056, 5595.076812325961, 5009.599232061463, 5034.672746271481, 5050.696958182484, 5055.342805435306, 5066.468020857794, 22122.668159977453, 22226.777732222632, 22854.885725571432, 22886.19898303568, 23139.53720925572, 2386.2244770449674, 2433.3551608823677, 2505.523950449409, 2539.860307683077, 2577.6391305217285, 14441.78337324941, 14512.201828899406, 14647.92676036613, 14861.777073343908, 14870.851291487055, 1933.1494142577362, 2015.4659015360942, 2030.35028790787, 2050.8564400491973, 2059.1969132038516, 59285.0, 70680.0, 75183.0, 78778.0, 81882.77175842426, 10345.534450949724, 10426.582936682447, 10589.84115238272, 10635.787284254271, 10923.836142457869, 14584.0, 14596.854031459761, 14649.707005859824, 14676.192809395372, 14740.410383584536, 7611.847763044708, 7811.609419529001, 7894.763157105296, 7915.564643944638, 8101.594920253964, 7670.923290767021, 7707.92292077072, 7816.6091695416135, 7980.082290536662, 8001.239882211181, 6563.967180164164, 6682.799516014527, 6688.398044176048, 6712.194536655633, 6717.1267735194115, 1855.2300795170124, 1929.778075521305, 1930.855185861066, 1949.1131535151471, 1982.7719812221778, 967.5984466446346, 987.9950600247097, 1104.309806371018, 1147.3574798112916, 1161.1465572803982, 19869.30457433983, 20576.691349629768, 20606.17575297001, 20779.68830467544, 20867.8956605216, 977.3012296208103, 992.6327258914248, 1016.8068067067234, 1042.3224903812581, 1062.2829590026702, 11286.66140015801, 11751.588694395827, 11849.111316651286, 11886.881131188751, 11896.22674526153, 467350.0, 468045.0, 470827.0, 480721.0, 493669.0, 75281.62359188279, 79187.0, 79876.0, 80353.19646803457, 80625.0, 996.8056229035413, 1000.869886914711, 1001.9198464122853, 1029.5469993202967, 1038.7610849504656, 14838.629034273798, 16843.494695159166, 17943.102844857443, 18550.814491854908, 18797.436076917715, 38971.6102838968, 39135.41296880606, 39965.40051899282, 40133.79933100316, 40920.59079409168, 49914.25128623146, 51421.0, 52486.0, 52496.737516313704, 52768.472315276354, 7355.77932662021, 8870.334724895787, 9031.729048128567, 9062.365634405529, 9276.07239276094, 11707.707307317385, 13558.796618050934, 13677.110987785762, 14241.35913883857, 14320.856791432368, 11968.281903085843, 12310.81533777012, 12441.191322564366, 12446.626601201979, 12596.0, 5479.260299859628, 9932.652357167464, 12031.699207519532, 12244.87755122473, 12540.87459125397, 11705.824412633987, 11960.64118076459, 12394.194377365442, 12650.810237846255, 12790.744185116431, 7524.811879703051, 8113.391495637733, 8294.37792165578, 8394.11861754507, 8741.213290803858, 11219.326840389604, 12143.75712485763, 12365.938170309091, 12489.31308778026, 12816.359182041047], "value": 9303.46746635391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.3505889879002, 1461.8684318411345, 1573.6537961648432, 1709.1795937949792, 1716.2620073368446, 7769.650365733542, 8415.158484151581, 8476.576171191447, 9148.085191480848, 9159.725208243746, 8702.390832641702, 8759.86860197096, 8807.207351338378, 8813.647454101829, 8828.161324674162, 2278.498730279336, 2314.143766806284, 2318.07277089164, 2328.4760928791056, 2331.160782118436, 2196.8681879087226, 2208.5803697297542, 2263.818894488437, 2263.845438826202, 2264.7395549511853, 2235.4523141830273, 2254.5040091179912, 2261.683364328995, 2269.387265438331, 2280.4754906371545, 2187.628103222448, 2238.9888050559807, 2247.494313779403, 2272.784085511874, 2274.7611500792427, 2236.932892013226, 2261.9095236190533, 2263.660450932357, 2266.875321857297, 2266.9886650566805, 8901.821963560757, 8913.688020919302, 8985.0, 9014.414063085878, 9068.7279381618, 4925.827596034122, 5063.772130254148, 5094.923576146361, 5102.285680004802, 5104.846854594331, 3103.193169775852, 3169.144331030609, 3299.637039925606, 3327.617324007722, 3333.7999720016633, 1137.2266858536193, 1162.3897453836719, 1165.2658824940318, 1171.7715045566117, 1193.922395044328, 12429.75140497185, 12460.75078498425, 12466.626001219978, 12505.06212034101, 12512.499500019989, 4433.490148632948, 4437.445319335083, 4571.245744452194, 4597.885052873638, 4613.123506533748, 10240.897591024144, 10294.279400441897, 10297.794044119075, 10323.690289291333, 10329.0, 5002.399712034507, 5005.649604527721, 5008.474110218447, 5025.221090730943, 5029.5221953914315, 4187.664986801049, 4525.932111018337, 4606.746628935373, 4622.838200662961, 4753.096911586787, 3904.4338570907626, 3911.78485183312, 4001.339778936443, 4043.3126368517424, 4046.433499310099, 1197.9161458697808, 1198.7362780188344, 1200.609801814414, 1216.5377156680404, 1221.151299846598, 874.7419511244199, 886.1670030171618, 905.805251870851, 911.1617312072909, 928.5960607135918, 5764.827055188351, 5899.292084949833, 5974.522038236931, 6048.395160483917, 6188.257409110935, 932.6409332406937, 938.1650331205233, 957.9089986451276, 960.673371053845, 965.2712202287228, 3828.73198876076, 3956.9909673033194, 3964.306246406867, 4000.699947503949, 4028.093678922219, 10740.30188037775, 10777.89222107769, 11127.944360278309, 11129.888701113046, 11183.105351572018, 11116.166287528467, 11132.721681958015, 11162.0, 11178.608748693756, 11179.0, 8075.798105047304, 8125.674973001013, 8173.427860049739, 8279.37904657141, 8318.209770071833, 5702.543796496353, 5767.567432442667, 5852.912206316993, 5895.263092113486, 5919.141724449844, 9242.214411774805, 9607.039296070338, 10160.136388407069, 10253.84619230727, 10276.075153236245, 9869.210463163074, 10074.093331600192, 10111.797764044824, 10173.389596624227, 10174.796504070026, 7072.893906591303, 7401.370883474965, 7692.269234422721, 7757.340626046624, 7973.601319934096, 8588.871166932377, 8704.91295087041, 8907.73276801697, 8921.0, 8925.73222803317, 7475.140358858584, 7649.579273140031, 7708.612449759097, 7793.2596403341595, 7871.055473343006, 7496.7750967471065, 7664.923350766644, 7711.768646940601, 7802.726904558313, 7888.6450109744055, 7127.786166415016, 7140.428765698628, 7172.103487064117, 7184.425245980414, 7192.4246060314, 5142.794288228429, 5196.168613021899, 5251.789928402974, 5266.947330526799, 5318.308619879391, 5247.7113758743635, 5339.7063161526485, 5375.381831089475, 5460.945390546044, 5476.561875050066], "value": 4602.689550827814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.30813442963205, 328.46460269760286, 331.57227176941745, 333.52639252261787, 333.8113965609429, 5398.541124004464, 5583.776648934037, 5620.690862002588, 5721.656700597967, 5735.799247026355, 5603.943960560403, 5627.0, 5632.211490391349, 5633.915491267634, 5635.3237611486575, 4321.265384884561, 4343.869683909487, 4376.452943382077, 4403.710070763202, 4424.6283652067805, 4133.23535145999, 4374.60628543431, 4378.8905277368, 4434.334849772527, 4447.0661161156195, 4308.138372325532, 4313.1158112586845, 4316.892077698051, 4335.913281734363, 4338.370936214247, 4349.934750978754, 4360.23695853226, 4363.1273745250755, 4374.9219120917305, 4414.624756895668, 3726.4224045272754, 3783.5459744830796, 3825.445310429972, 3834.2906562286066, 3836.5779764225913, 5426.294581704393, 5429.212764149176, 5442.91835622466, 5492.258545096401, 5514.621344663834, 4944.332515110486, 4958.851234462972, 4996.725180115092, 5006.699598024094, 5009.574186194178, 5767.740451679684, 5873.916193998142, 5912.645241285493, 5914.733836977346, 5978.432048955342, 4101.985040994867, 4119.299719047769, 4139.5653456387245, 4160.958390416087, 4163.8959026024595, 6080.844639518477, 6127.356627554087, 6141.57009009374, 6147.938520614826, 6167.660778657172, 4140.3168477201525, 4166.812493437742, 4192.601702838226, 4209.6000879916355, 4300.290452075373, 4214.978925105354, 4242.8727138185905, 4279.550647182001, 4323.092150648399, 4328.588784065509, 4946.604271658259, 4972.5027497249985, 4980.178270585313, 4999.65002449825, 5001.299818025406, 5691.231683722727, 5894.498967587718, 5919.644821310735, 5945.227120474397, 5980.970095149496, 1464.2020099046044, 1485.042147814675, 1490.5826368616804, 1491.1500444746391, 1495.1851241073641, 911.7720569857536, 941.6798288581915, 945.2674177512346, 945.9810803783886, 963.797602503468, 5021.865707074478, 5039.344885164978, 5068.797248110034, 5087.821926232564, 5108.412532558729, 5371.6239863209985, 5407.45925407464, 5492.395836457987, 5501.944980550224, 5508.834734957877, 4842.539958703917, 4964.826231081895, 5040.974795126001, 5073.264376665363, 5089.898202035939, 2835.489611869842, 2876.3096856754228, 2895.537753434502, 2912.723291287324, 2927.6047733556125, 5469.304515600176, 5471.835844924659, 5505.183289514531, 5583.525400340935, 5651.897879913377, 5482.150266708587, 5835.299764028344, 6342.968285158637, 6345.111684364193, 6345.460635845912, 6382.585131966407, 6408.166938297992, 6438.452731517874, 6450.77422290227, 6459.483241340681, 5907.261592300963, 6073.453389194994, 6095.299040610209, 6130.356312587114, 6169.753209871555, 5972.820815375546, 6033.909491357545, 6042.607230530001, 6101.328853826164, 6118.051701986199, 6052.3658612173585, 6134.079888016833, 6336.841578960563, 6392.584482008655, 6396.712147953446, 4325.632321252603, 4333.631641310524, 4363.738175709467, 4371.781410929504, 4397.340398940057, 5988.011978023752, 6006.729697163551, 6047.848803779764, 6101.7559297627595, 6116.541259405473, 5711.60065783869, 5871.647701137946, 5886.735096920735, 5890.852728681817, 5899.911501327398, 5831.94168058314, 5838.32859221178, 5859.648421094748, 5882.23530940975, 5894.646321220741, 5529.972350138223, 5778.364379918122, 5793.8551536211935, 5809.501914176944, 5833.8249852502795, 5998.6802903361195, 6004.639721616717, 6010.909836352371, 6033.974224381778, 6040.305364883095, 5850.327212370632, 5894.288627231522, 5916.230889984447, 5933.525317974465, 5939.16851640762], "value": 4409.130666850847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9018682477865, 741.9279141640328, 788.1173086143518, 789.1201310538747, 811.8173410982525, 14585.416583336668, 16274.674506509862, 16364.099974501398, 16373.75439368409, 16381.42665006725, 14115.858841411582, 14120.858791412084, 14130.788038179435, 14172.362243699032, 14207.857921420782, 663.1180529895228, 771.0708596141664, 778.832551001536, 787.940904432167, 793.7221972309675, 778.17513435758, 781.4764108047593, 784.7920301120208, 786.3669745854585, 788.6963519045152, 849.3757088539918, 850.3367373448689, 851.748734123432, 852.2840813716477, 853.56894768142, 840.9243168114868, 844.5988155626089, 845.0999685335129, 845.2350622686479, 845.3533047218882, 614.1770028162284, 616.2081724983419, 616.2974209401286, 616.7687117331001, 618.3291129124905, 14647.12117272967, 14648.926755366156, 14672.70654586913, 14708.779368309484, 14710.866924295917, 15079.773803392958, 15199.240037998055, 15219.543413697496, 15228.695426091415, 15280.235988200546, 12247.448864801105, 12333.444994975247, 12383.0, 12423.937880310541, 12550.1842380245, 3835.668420894958, 3880.2864921632936, 3882.475865758143, 3933.2723446162267, 3948.072203032285, 72494.0, 72585.63707181482, 72711.0, 73277.90083148757, 74439.99999999946, 10999.61501347449, 11040.558377664804, 11112.944435277934, 11357.432128393548, 11379.37413442252, 22431.551368972854, 23097.307080787603, 23115.07539698393, 23129.0, 23226.419339516648, 8366.58167091643, 8376.413651044368, 8434.24091831738, 8454.281386082252, 8543.530105844115, 4577.473590537131, 4719.95280047202, 4822.565969062731, 4882.414110306786, 4916.041371932439, 3299.3566254580605, 3478.0783092480515, 3483.146629075842, 3484.686378225972, 3496.30073985204, 609.58243603132, 632.6299115017766, 633.5406830048178, 637.5791977294963, 637.9298277189505, 500.2820951933986, 572.287502059938, 610.4780412747126, 621.2234706616729, 669.5915491550151, 9422.62309507612, 9531.285153613506, 9574.377665451724, 9656.468894210746, 9949.0, 626.2578844069701, 658.96375699337, 661.4047357378302, 689.5173378634976, 695.1380288442296, 4476.37330773692, 4515.88710282239, 4541.727496350163, 4557.680962332671, 4633.976830115827, 117086.0, 118068.0, 119590.0, 123591.38204309101, 124088.37955810163, 99005.50497247612, 103115.0, 103394.0, 103845.0, 104288.0, 87853.0, 88101.95184385234, 88206.0, 88671.0, 89061.0, 9774.511274436392, 9923.156531694887, 10064.798704026025, 10319.432431216355, 10603.681889543326, 48552.0, 50352.24471633002, 51227.743861281946, 51715.0, 53346.1998070037, 69653.30346696469, 74722.25277747153, 75168.0, 75675.0, 76215.61892190503, 12901.0, 12937.611871643488, 12944.15862968904, 13102.541411050568, 13203.078153108443, 14027.437628178439, 14154.292285385896, 14255.358508866919, 14512.927435362755, 14828.777568336267, 13155.144915580457, 13492.460301587827, 13749.587512374645, 13845.584632461043, 14174.716505670036, 13168.60494185176, 13506.189628622315, 13678.316084195949, 13875.306234688427, 14478.27608619586, 12729.745405092031, 13250.801237981244, 13345.799813002619, 13506.189628622315, 14224.857751422353, 10969.149885923953, 11480.253783504046, 11482.598109066143, 11623.59317423886, 11803.704907377385, 9751.804963900824, 9852.241322544944, 9953.104220620178, 9979.351342162736, 10017.198624110199], "value": 7502.953276258039, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 103.0, 109.0, 111.0, 110.0, 112.0, 110.0, 110.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 157.0, 194.0, 128.0, 164.0, 160.0, 136.0, 189.0, 134.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 161.0, 161.0, 161.0, 167.0, 177.0, 164.0, 163.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 76.0, 157.0, 76.0, 75.0, 76.0, 75.0, 163.0, 78.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 156.0, 86.0, 86.0, 85.0, 138.0, 85.0, 89.0, 136.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 59.0, 56.0, 58.0, 55.0, 56.0, 59.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 64.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 79.0, 84.0, 80.0, 80.0, 82.0, 83.0, 128.0, 78.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 123.0, 121.0, 120.0, 121.0, 134.0, 133.0, 132.0, 122.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 157.0, 161.0, 156.0, 159.0, 159.0, 161.0, 175.0, 167.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 63.0, 65.0, 63.0, 68.0, 62.0, 64.0, 62.0], "value": 63.9, "unit": "score"}]}]} 22:51:08 INFO - Return code: 0 22:51:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:51:08 ERROR - # TBPL SUCCESS # 22:51:08 INFO - Running post-action listener: _resource_record_post_action 22:51:08 INFO - ##### 22:51:08 INFO - ##### Finished run-tests step (success) 22:51:08 INFO - ##### 22:51:08 INFO - Running post-run listener: _resource_record_post_run 22:51:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555696128; Read time: 16; Write time: 516856 22:51:08 INFO - TinderboxPrint: CPU usage
13.5% 22:51:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:51:08 INFO - TinderboxPrint: I/O write bytes / time
555,696,128 / 516,856 22:51:08 INFO - TinderboxPrint: CPU idle
8,221.0 (86.5%) 22:51:08 INFO - TinderboxPrint: CPU user
1,226.1 (12.9%) 22:51:08 INFO - TinderboxPrint: Swap in / out
0 / 0 22:51:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256782336; Read time: 0; Write time: 278940 22:51:08 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298856448; Read time: 16; Write time: 237896 22:51:09 INFO - Running post-run listener: _upload_blobber_files 22:51:09 INFO - Blob upload gear active. 22:51:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:51:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:51:09 INFO - (blobuploader) - INFO - Open directory for files ... 22:51:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:51:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:51:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:10 INFO - (blobuploader) - INFO - Done attempting. 22:51:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:51:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:11 INFO - (blobuploader) - INFO - Done attempting. 22:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:51:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:15 INFO - (blobuploader) - INFO - Done attempting. 22:51:15 INFO - (blobuploader) - INFO - Iteration through files over. 22:51:15 INFO - Return code: 0 22:51:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:51:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:51:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300ff6801b280f215824e808f886d02e427901d15d76570efbb16d88f8b7717ec3fb1177e2457ee2bfc0d75e849d6106fe0bcdef5c5223dcfc129fb092070ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52de118e2ea83fb663f292a4a1846e30aef3bf98bdea45ee11947eabd56dc74bd88420aa69bfdfa21c1e0600344463f8173aadb65fa6f4efe64172fe1eb8e699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/668df5ebc77525b8750ec846de23e88b4017ab1bfbdaed2dcd0c9a35c945e21e95a1ec965f245e311f1a92ae22cc97d15c86a4e87a680014b1b2c0aaaef1f34a"} 22:51:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:51:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:51:15 INFO - Contents: 22:51:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300ff6801b280f215824e808f886d02e427901d15d76570efbb16d88f8b7717ec3fb1177e2457ee2bfc0d75e849d6106fe0bcdef5c5223dcfc129fb092070ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52de118e2ea83fb663f292a4a1846e30aef3bf98bdea45ee11947eabd56dc74bd88420aa69bfdfa21c1e0600344463f8173aadb65fa6f4efe64172fe1eb8e699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/668df5ebc77525b8750ec846de23e88b4017ab1bfbdaed2dcd0c9a35c945e21e95a1ec965f245e311f1a92ae22cc97d15c86a4e87a680014b1b2c0aaaef1f34a"} 22:51:15 INFO - Running post-run listener: copy_logs_to_upload_dir 22:51:15 INFO - Copying logs to upload dir... 22:51:15 INFO - mkdir: /builds/slave/test/build/upload/logs 22:51:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.090362 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-27 22:51:14.653045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 22:51:14.656989) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300ff6801b280f215824e808f886d02e427901d15d76570efbb16d88f8b7717ec3fb1177e2457ee2bfc0d75e849d6106fe0bcdef5c5223dcfc129fb092070ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52de118e2ea83fb663f292a4a1846e30aef3bf98bdea45ee11947eabd56dc74bd88420aa69bfdfa21c1e0600344463f8173aadb65fa6f4efe64172fe1eb8e699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/668df5ebc77525b8750ec846de23e88b4017ab1bfbdaed2dcd0c9a35c945e21e95a1ec965f245e311f1a92ae22cc97d15c86a4e87a680014b1b2c0aaaef1f34a"} build_url:https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/300ff6801b280f215824e808f886d02e427901d15d76570efbb16d88f8b7717ec3fb1177e2457ee2bfc0d75e849d6106fe0bcdef5c5223dcfc129fb092070ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52de118e2ea83fb663f292a4a1846e30aef3bf98bdea45ee11947eabd56dc74bd88420aa69bfdfa21c1e0600344463f8173aadb65fa6f4efe64172fe1eb8e699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/668df5ebc77525b8750ec846de23e88b4017ab1bfbdaed2dcd0c9a35c945e21e95a1ec965f245e311f1a92ae22cc97d15c86a4e87a680014b1b2c0aaaef1f34a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 22:51:14.689669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:51:14.690273) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1467086020.441307-205128115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:51:14.773385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 22:51:14.773707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 22:51:14.774029) ========= ========= Total master_lag: 0.18 =========