builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1466788404.64 results: success (0) buildid: 20160624073140 builduid: cc10eb24922242aca40a385e63ed4b5f revision: a277f3e065d2a4026a6c10d2dae02699ef30a504 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:24.639113) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:24.639533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:24.639843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:24.659177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:24.659499) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 10:13:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-06-24 10:13:24 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086571 ========= master_lag: 0.33 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.077235) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.077562) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015333 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.105162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.106334) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a277f3e065d2a4026a6c10d2dae02699ef30a504 --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 a277f3e065d2a4026a6c10d2dae02699ef30a504 --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=8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 10:13:25,112 truncating revision to first 12 chars 2016-06-24 10:13:25,112 Setting DEBUG logging. 2016-06-24 10:13:25,112 attempt 1/10 2016-06-24 10:13:25,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a277f3e065d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 10:13:25,568 unpacking tar archive at: mozilla-inbound-a277f3e065d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.866942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.989490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.989867) ========= script_repo_revision: a277f3e065d2a4026a6c10d2dae02699ef30a504 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.990404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:25.990723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 10:13:26.001759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 10:13:26.002151) ========= /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=8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:26 INFO - MultiFileLogger online at 20160624 10:13:26 in /builds/slave/test 10:13:26 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 10:13:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:26 INFO - {'append_to_log': False, 10:13:26 INFO - 'base_work_dir': '/builds/slave/test', 10:13:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:13:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:26 INFO - 'branch': 'Mozilla-Inbound', 10:13:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:26 INFO - 'config_files': ('talos/linux_config.py',), 10:13:26 INFO - 'default_actions': ('clobber', 10:13:26 INFO - 'read-buildbot-config', 10:13:26 INFO - 'download-and-extract', 10:13:26 INFO - 'populate-webroot', 10:13:26 INFO - 'create-virtualenv', 10:13:26 INFO - 'install', 10:13:26 INFO - 'run-tests'), 10:13:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:26 INFO - 'download_minidump_stackwalk': True, 10:13:26 INFO - 'download_symbols': 'ondemand', 10:13:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:26 INFO - 'installer_path': 'installer.exe', 10:13:26 INFO - 'log_level': 'info', 10:13:26 INFO - 'log_name': 'talos', 10:13:26 INFO - 'log_to_console': True, 10:13:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:26 INFO - 'opt_config_files': (), 10:13:26 INFO - 'pip_index': False, 10:13:26 INFO - 'sps_profile': False, 10:13:26 INFO - 'sps_profile_interval': 0, 10:13:26 INFO - 'suite': 'dromaeojs-e10s', 10:13:26 INFO - 'system_bits': '32', 10:13:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:26 INFO - 'title': 'talos-linux64-ix-001', 10:13:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:26 INFO - 'use_talos_json': True, 10:13:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:26 INFO - 'work_dir': 'build'} 10:13:26 INFO - ##### 10:13:26 INFO - ##### Running clobber step. 10:13:26 INFO - ##### 10:13:26 INFO - Running pre-action listener: _resource_record_pre_action 10:13:26 INFO - Running main action method: clobber 10:13:26 INFO - rmtree: /builds/slave/test/build 10:13:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:26 INFO - Running post-action listener: _resource_record_post_action 10:13:26 INFO - ##### 10:13:26 INFO - ##### Finished clobber step (success) 10:13:26 INFO - ##### 10:13:26 INFO - ##### 10:13:26 INFO - ##### Running read-buildbot-config step. 10:13:26 INFO - ##### 10:13:26 INFO - Running pre-action listener: _resource_record_pre_action 10:13:26 INFO - Running main action method: read_buildbot_config 10:13:26 INFO - Using buildbot properties: 10:13:26 INFO - { 10:13:26 INFO - "project": "", 10:13:26 INFO - "product": "firefox", 10:13:26 INFO - "script_repo_revision": "production", 10:13:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:13:26 INFO - "repository": "", 10:13:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:13:26 INFO - "buildid": "20160624073140", 10:13:26 INFO - "pgo_build": "True", 10:13:26 INFO - "basedir": "/builds/slave/test", 10:13:26 INFO - "buildnumber": 1212, 10:13:26 INFO - "slavename": "talos-linux64-ix-001", 10:13:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:13:26 INFO - "platform": "ubuntu64_hw", 10:13:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:13:26 INFO - "branch": "mozilla-inbound", 10:13:26 INFO - "repo_path": "integration/mozilla-inbound", 10:13:26 INFO - "revision": "a277f3e065d2a4026a6c10d2dae02699ef30a504", 10:13:26 INFO - "stage_platform": "linux64-pgo", 10:13:26 INFO - "builduid": "cc10eb24922242aca40a385e63ed4b5f", 10:13:26 INFO - "slavebuilddir": "test" 10:13:26 INFO - } 10:13:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:13:26 INFO - Running post-action listener: _resource_record_post_action 10:13:26 INFO - ##### 10:13:26 INFO - ##### Finished read-buildbot-config step (success) 10:13:26 INFO - ##### 10:13:26 INFO - ##### 10:13:26 INFO - ##### Running download-and-extract step. 10:13:26 INFO - ##### 10:13:26 INFO - Running pre-action listener: _resource_record_pre_action 10:13:26 INFO - Running main action method: download_and_extract 10:13:26 INFO - mkdir: /builds/slave/test/build/tests 10:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:26 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:13:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:13:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:13:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:27 INFO - Downloaded 1361 bytes. 10:13:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:13:27 INFO - Using the following test package requirements: 10:13:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:13:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'jsshell-linux-x86_64.zip'], 10:13:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:13:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:13:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:27 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:28 INFO - Downloaded 24279651 bytes. 10:13:28 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'] 10:13:28 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 10:13:29 INFO - Return code: 0 10:13:29 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 10:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:29 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:13:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:13:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:31 INFO - Downloaded 24279651 bytes. 10:13:31 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'] 10:13:31 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 10:13:32 INFO - Return code: 0 10:13: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')]} 10:13:32 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:13:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:33 INFO - Downloaded 14405188 bytes. 10:13:33 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'] 10:13:33 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 10:13:33 INFO - Return code: 0 10:13:33 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')]} 10:13:33 INFO - https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:13:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:13:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:13:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_ExEQJNQkedwnLLPQQHFg/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 10:13:35 INFO - Downloaded 60162562 bytes. 10:13:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:13:35 INFO - mkdir: /builds/slave/test/properties 10:13:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:35 INFO - Contents: 10:13:35 INFO - build_url:https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:13:35 INFO - Running post-action listener: _resource_record_post_action 10:13:36 INFO - Running post-action listener: set_extra_try_arguments 10:13:36 INFO - ##### 10:13:36 INFO - ##### Finished download-and-extract step (success) 10:13:36 INFO - ##### 10:13:36 INFO - ##### 10:13:36 INFO - ##### Running populate-webroot step. 10:13:36 INFO - ##### 10:13:36 INFO - Running pre-action listener: _resource_record_pre_action 10:13:36 INFO - Running main action method: populate_webroot 10:13:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:36 INFO - '--tppagecycles', 10:13:36 INFO - '7'], 10:13:36 INFO - 'tests': ['tsvgm']}}, 10:13:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['damp', 'tps']}, 10:13:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'tests': ['damp', 'tps']}, 10:13:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['dromaeo_dom']}, 10:13:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['basic_compositor_video']}, 10:13:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:13:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['a11yr', 10:13:36 INFO - 'ts_paint', 10:13:36 INFO - 'tpaint', 10:13:36 INFO - 'sessionrestore', 10:13:36 INFO - 'sessionrestore_no_auto_restore', 10:13:36 INFO - 'tabpaint']}, 10:13:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:36 INFO - 'ts_paint', 10:13:36 INFO - 'tpaint', 10:13:36 INFO - 'sessionrestore', 10:13:36 INFO - 'sessionrestore_no_auto_restore', 10:13:36 INFO - 'tabpaint']}, 10:13:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:36 INFO - 'ts_paint', 10:13:36 INFO - 'tpaint', 10:13:36 INFO - 'sessionrestore', 10:13:36 INFO - 'sessionrestore_no_auto_restore', 10:13:36 INFO - 'tabpaint']}, 10:13:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:36 INFO - 'ts_paint', 10:13:36 INFO - 'tpaint', 10:13:36 INFO - 'sessionrestore', 10:13:36 INFO - 'sessionrestore_no_auto_restore', 10:13:36 INFO - 'tabpaint']}, 10:13:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['a11yr', 10:13:36 INFO - 'ts_paint', 10:13:36 INFO - 'tpaint', 10:13:36 INFO - 'sessionrestore', 10:13:36 INFO - 'sessionrestore_no_auto_restore', 10:13:36 INFO - 'tabpaint']}, 10:13:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['a11yr', 10:13:36 INFO - 'ts_paint', 10:13:36 INFO - 'tpaint', 10:13:36 INFO - 'sessionrestore', 10:13:36 INFO - 'sessionrestore_no_auto_restore', 10:13:36 INFO - 'tabpaint']}, 10:13:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['tsvgx', 10:13:36 INFO - 'tsvgr_opacity', 10:13:36 INFO - 'tart', 10:13:36 INFO - 'tscrollx', 10:13:36 INFO - 'cart']}, 10:13:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:36 INFO - 'tsvgr_opacity', 10:13:36 INFO - 'tart', 10:13:36 INFO - 'tscrollx', 10:13:36 INFO - 'cart']}, 10:13:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'talos_options': ['--disable-e10s'], 10:13:36 INFO - 'tests': ['tp5o']}, 10:13:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'tests': ['tp5o']}, 10:13:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'talos_options': ['--disable-e10s', 10:13:36 INFO - '--xperf_path', 10:13:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:36 INFO - 'tests': ['tp5n']}, 10:13:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:36 INFO - 'talos_options': ['--xperf_path', 10:13:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:36 INFO - 'tests': ['tp5n']}}, 10:13:36 INFO - 'talos.zip': {'path': '', 10:13:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:36 INFO - Running post-action listener: _resource_record_post_action 10:13:36 INFO - ##### 10:13:36 INFO - ##### Finished populate-webroot step (success) 10:13:36 INFO - ##### 10:13:36 INFO - ##### 10:13:36 INFO - ##### Running create-virtualenv step. 10:13:36 INFO - ##### 10:13:36 INFO - Running pre-action listener: _resource_record_pre_action 10:13:36 INFO - Running main action method: create_virtualenv 10:13:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:36 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 10:13:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:36 INFO - Using real prefix '/usr' 10:13:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:38 INFO - Installing pip.................done. 10:13:38 INFO - Return code: 0 10:13:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:38 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')]} 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 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')]} 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:38 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 10:13:38 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 10:13:38 INFO - Using env: {'DISPLAY': ':0', 10:13:38 INFO - 'HOME': '/home/cltbld', 10:13:38 INFO - 'LANG': 'en_US.UTF-8', 10:13:38 INFO - 'LANGUAGE': 'en_US:en', 10:13:38 INFO - 'LOGNAME': 'cltbld', 10:13:38 INFO - 'MAIL': '/var/mail/cltbld', 10:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:38 INFO - 'MOZ_NO_REMOTE': '1', 10:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:38 INFO - 'NO_EM_RESTART': '1', 10:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:38 INFO - 'PWD': '/builds/slave/test', 10:13:38 INFO - 'SHELL': '/bin/bash', 10:13:38 INFO - 'SHLVL': '1', 10:13:38 INFO - 'TERM': 'linux', 10:13:38 INFO - 'TMOUT': '86400', 10:13:38 INFO - 'USER': 'cltbld', 10:13:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:38 INFO - '_': '/tools/buildbot/bin/python'} 10:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:39 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 10:13:39 INFO - Cleaning up... 10:13:39 INFO - Return code: 0 10:13:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:39 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:39 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 10:13:39 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 10:13:39 INFO - Using env: {'DISPLAY': ':0', 10:13:39 INFO - 'HOME': '/home/cltbld', 10:13:39 INFO - 'LANG': 'en_US.UTF-8', 10:13:39 INFO - 'LANGUAGE': 'en_US:en', 10:13:39 INFO - 'LOGNAME': 'cltbld', 10:13:39 INFO - 'MAIL': '/var/mail/cltbld', 10:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:39 INFO - 'MOZ_NO_REMOTE': '1', 10:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:39 INFO - 'NO_EM_RESTART': '1', 10:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:39 INFO - 'PWD': '/builds/slave/test', 10:13:39 INFO - 'SHELL': '/bin/bash', 10:13:39 INFO - 'SHLVL': '1', 10:13:39 INFO - 'TERM': 'linux', 10:13:39 INFO - 'TMOUT': '86400', 10:13:39 INFO - 'USER': 'cltbld', 10:13:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:39 INFO - '_': '/tools/buildbot/bin/python'} 10:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:39 INFO - Downloading/unpacking psutil>=3.1.1 10:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:41 INFO - Installing collected packages: psutil 10:13:41 INFO - Running setup.py install for psutil 10:13:41 INFO - building 'psutil._psutil_linux' extension 10:13:41 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 10:13:41 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 10:13:41 INFO - building 'psutil._psutil_posix' extension 10:13:41 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 10:13:41 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 10:13:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:42 INFO - Successfully installed psutil 10:13:42 INFO - Cleaning up... 10:13:42 INFO - Return code: 0 10:13:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:42 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:42 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 10:13:42 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 10:13:42 INFO - Using env: {'DISPLAY': ':0', 10:13:42 INFO - 'HOME': '/home/cltbld', 10:13:42 INFO - 'LANG': 'en_US.UTF-8', 10:13:42 INFO - 'LANGUAGE': 'en_US:en', 10:13:42 INFO - 'LOGNAME': 'cltbld', 10:13:42 INFO - 'MAIL': '/var/mail/cltbld', 10:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:42 INFO - 'MOZ_NO_REMOTE': '1', 10:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:42 INFO - 'NO_EM_RESTART': '1', 10:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:42 INFO - 'PWD': '/builds/slave/test', 10:13:42 INFO - 'SHELL': '/bin/bash', 10:13:42 INFO - 'SHLVL': '1', 10:13:42 INFO - 'TERM': 'linux', 10:13:42 INFO - 'TMOUT': '86400', 10:13:42 INFO - 'USER': 'cltbld', 10:13:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:42 INFO - '_': '/tools/buildbot/bin/python'} 10:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:44 INFO - Installing collected packages: mozsystemmonitor 10:13:44 INFO - Running setup.py install for mozsystemmonitor 10:13:44 INFO - Successfully installed mozsystemmonitor 10:13:44 INFO - Cleaning up... 10:13:44 INFO - Return code: 0 10:13:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:44 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:44 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 10:13:44 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 10:13:44 INFO - Using env: {'DISPLAY': ':0', 10:13:44 INFO - 'HOME': '/home/cltbld', 10:13:44 INFO - 'LANG': 'en_US.UTF-8', 10:13:44 INFO - 'LANGUAGE': 'en_US:en', 10:13:44 INFO - 'LOGNAME': 'cltbld', 10:13:44 INFO - 'MAIL': '/var/mail/cltbld', 10:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:44 INFO - 'MOZ_NO_REMOTE': '1', 10:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:44 INFO - 'NO_EM_RESTART': '1', 10:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:44 INFO - 'PWD': '/builds/slave/test', 10:13:44 INFO - 'SHELL': '/bin/bash', 10:13:44 INFO - 'SHLVL': '1', 10:13:44 INFO - 'TERM': 'linux', 10:13:44 INFO - 'TMOUT': '86400', 10:13:44 INFO - 'USER': 'cltbld', 10:13:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:44 INFO - '_': '/tools/buildbot/bin/python'} 10:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:45 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:45 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 10:13:45 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 10:13:45 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 10:13:45 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 10:13:45 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 10:13:45 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 10:13:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:47 INFO - warning: no files found matching '*.txt' 10:13:47 INFO - no previously-included directories found matching 'build' 10:13:47 INFO - no previously-included directories found matching 'dist' 10:13:47 INFO - no previously-included directories found matching '.git*' 10:13:47 INFO - Installing collected packages: jsonschema, functools32 10:13:47 INFO - Running setup.py install for functools32 10:13:47 INFO - warning: no files found matching '*.txt' 10:13:47 INFO - no previously-included directories found matching 'build' 10:13:47 INFO - no previously-included directories found matching 'dist' 10:13:47 INFO - no previously-included directories found matching '.git*' 10:13:47 INFO - Successfully installed jsonschema functools32 10:13:47 INFO - Cleaning up... 10:13:47 INFO - Return code: 0 10:13:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:47 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')]} 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:47 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')]} 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:47 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:47 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 10:13:47 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 10:13:47 INFO - Using env: {'DISPLAY': ':0', 10:13:47 INFO - 'HOME': '/home/cltbld', 10:13:47 INFO - 'LANG': 'en_US.UTF-8', 10:13:47 INFO - 'LANGUAGE': 'en_US:en', 10:13:47 INFO - 'LOGNAME': 'cltbld', 10:13:47 INFO - 'MAIL': '/var/mail/cltbld', 10:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:47 INFO - 'MOZ_NO_REMOTE': '1', 10:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:47 INFO - 'NO_EM_RESTART': '1', 10:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:47 INFO - 'PWD': '/builds/slave/test', 10:13:47 INFO - 'SHELL': '/bin/bash', 10:13:47 INFO - 'SHLVL': '1', 10:13:47 INFO - 'TERM': 'linux', 10:13:47 INFO - 'TMOUT': '86400', 10:13:47 INFO - 'USER': 'cltbld', 10:13:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:47 INFO - '_': '/tools/buildbot/bin/python'} 10:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:50 INFO - Downloading docopt-0.6.1.tar.gz 10:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:50 INFO - Running setup.py install for blobuploader 10:13:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:50 INFO - Running setup.py install for requests 10:13:50 INFO - Running setup.py install for docopt 10:13:50 INFO - Successfully installed blobuploader requests docopt 10:13:50 INFO - Cleaning up... 10:13:50 INFO - Return code: 0 10:13:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:50 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:50 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 10:13:50 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 10:13:50 INFO - Using env: {'DISPLAY': ':0', 10:13:50 INFO - 'HOME': '/home/cltbld', 10:13:50 INFO - 'LANG': 'en_US.UTF-8', 10:13:50 INFO - 'LANGUAGE': 'en_US:en', 10:13:50 INFO - 'LOGNAME': 'cltbld', 10:13:50 INFO - 'MAIL': '/var/mail/cltbld', 10:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:50 INFO - 'MOZ_NO_REMOTE': '1', 10:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:50 INFO - 'NO_EM_RESTART': '1', 10:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:50 INFO - 'PWD': '/builds/slave/test', 10:13:50 INFO - 'SHELL': '/bin/bash', 10:13:50 INFO - 'SHLVL': '1', 10:13:50 INFO - 'TERM': 'linux', 10:13:50 INFO - 'TMOUT': '86400', 10:13:50 INFO - 'USER': 'cltbld', 10:13:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:50 INFO - '_': '/tools/buildbot/bin/python'} 10:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:51 INFO - Running setup.py (path:/tmp/pip-k9UX71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:51 INFO - Running setup.py (path:/tmp/pip-ubvqVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:51 INFO - Running setup.py (path:/tmp/pip-KvRj_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:51 INFO - Running setup.py (path:/tmp/pip-lmqxcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:51 INFO - Running setup.py (path:/tmp/pip-9rKhdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:51 INFO - Running setup.py (path:/tmp/pip-Ujltyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:51 INFO - Running setup.py (path:/tmp/pip-FqI7bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:51 INFO - Running setup.py (path:/tmp/pip-C3CF5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:51 INFO - Running setup.py (path:/tmp/pip-Bj4v9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:51 INFO - Running setup.py (path:/tmp/pip-HF6TvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:51 INFO - Running setup.py (path:/tmp/pip-Aliupa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:51 INFO - Running setup.py (path:/tmp/pip-ErPXkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:52 INFO - Running setup.py (path:/tmp/pip-3AsIud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:52 INFO - Running setup.py (path:/tmp/pip-tJ2rYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:52 INFO - Running setup.py (path:/tmp/pip-DRHGKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:52 INFO - Running setup.py (path:/tmp/pip-qDoKpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:52 INFO - Running setup.py (path:/tmp/pip-eWo56r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:52 INFO - Running setup.py install for manifestparser 10:13:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:52 INFO - Running setup.py install for mozcrash 10:13:52 INFO - Running setup.py install for mozdebug 10:13:52 INFO - Running setup.py install for mozdevice 10:13:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:52 INFO - Running setup.py install for mozfile 10:13:52 INFO - Running setup.py install for mozhttpd 10:13:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:52 INFO - Running setup.py install for mozinfo 10:13:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Running setup.py install for mozInstall 10:13:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Running setup.py install for mozleak 10:13:53 INFO - Running setup.py install for mozlog 10:13:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Running setup.py install for moznetwork 10:13:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Running setup.py install for mozprocess 10:13:53 INFO - Running setup.py install for mozprofile 10:13:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Running setup.py install for mozrunner 10:13:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:53 INFO - Running setup.py install for mozscreenshot 10:13:53 INFO - Running setup.py install for moztest 10:13:54 INFO - Running setup.py install for mozversion 10:13:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:54 INFO - Cleaning up... 10:13:54 INFO - Return code: 0 10:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:54 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')]} 10:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:54 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')]} 10:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:54 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:54 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 10:13:54 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 10:13:54 INFO - Using env: {'DISPLAY': ':0', 10:13:54 INFO - 'HOME': '/home/cltbld', 10:13:54 INFO - 'LANG': 'en_US.UTF-8', 10:13:54 INFO - 'LANGUAGE': 'en_US:en', 10:13:54 INFO - 'LOGNAME': 'cltbld', 10:13:54 INFO - 'MAIL': '/var/mail/cltbld', 10:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:54 INFO - 'MOZ_NO_REMOTE': '1', 10:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:54 INFO - 'NO_EM_RESTART': '1', 10:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:54 INFO - 'PWD': '/builds/slave/test', 10:13:54 INFO - 'SHELL': '/bin/bash', 10:13:54 INFO - 'SHLVL': '1', 10:13:54 INFO - 'TERM': 'linux', 10:13:54 INFO - 'TMOUT': '86400', 10:13:54 INFO - 'USER': 'cltbld', 10:13:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:54 INFO - '_': '/tools/buildbot/bin/python'} 10:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:54 INFO - Running setup.py (path:/tmp/pip-soMAGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:54 INFO - Running setup.py (path:/tmp/pip-0nU0Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:54 INFO - Running setup.py (path:/tmp/pip-t11qD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:54 INFO - Running setup.py (path:/tmp/pip-M9faEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:54 INFO - Running setup.py (path:/tmp/pip-tI44Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:54 INFO - Running setup.py (path:/tmp/pip-qMC6g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:54 INFO - Running setup.py (path:/tmp/pip-9jeL7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:54 INFO - Running setup.py (path:/tmp/pip-tgEgRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:54 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)) 10:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:54 INFO - Running setup.py (path:/tmp/pip-MW6n_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:55 INFO - Running setup.py (path:/tmp/pip-Xd1QzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:55 INFO - Running setup.py (path:/tmp/pip-NB3UQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:55 INFO - Running setup.py (path:/tmp/pip-zqiuv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:55 INFO - Running setup.py (path:/tmp/pip-IR_OK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:55 INFO - Running setup.py (path:/tmp/pip-bZV42I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:55 INFO - Running setup.py (path:/tmp/pip-jiRaeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:55 INFO - Running setup.py (path:/tmp/pip-1jLuUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:55 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)) 10:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:55 INFO - Running setup.py (path:/tmp/pip-faAfb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:55 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)) 10:13:55 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)) 10:13:55 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)) 10:13:55 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)) 10:13:55 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)) 10:13:55 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)) 10:13:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:57 INFO - Downloading blessings-1.6.tar.gz 10:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:57 INFO - Installing collected packages: blessings 10:13:57 INFO - Running setup.py install for blessings 10:13:57 INFO - Successfully installed blessings 10:13:57 INFO - Cleaning up... 10:13:57 INFO - Return code: 0 10:13:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:57 INFO - Reading from file tmpfile_stdout 10:13:57 INFO - Current package versions: 10:13:57 INFO - argparse == 1.2.1 10:13:57 INFO - blessings == 1.6 10:13:57 INFO - blobuploader == 1.2.4 10:13:57 INFO - docopt == 0.6.1 10:13:57 INFO - functools32 == 3.2.3-2 10:13:57 INFO - jsonschema == 2.5.1 10:13:57 INFO - manifestparser == 1.1 10:13:57 INFO - mozInstall == 1.12 10:13:57 INFO - mozcrash == 0.17 10:13:57 INFO - mozdebug == 0.1 10:13:57 INFO - mozdevice == 0.48 10:13:57 INFO - mozfile == 1.2 10:13:57 INFO - mozhttpd == 0.7 10:13:57 INFO - mozinfo == 0.9 10:13:57 INFO - mozleak == 0.1 10:13:57 INFO - mozlog == 3.2 10:13:57 INFO - moznetwork == 0.27 10:13:57 INFO - mozprocess == 0.22 10:13:57 INFO - mozprofile == 0.28 10:13:57 INFO - mozrunner == 6.11 10:13:57 INFO - mozscreenshot == 0.1 10:13:57 INFO - mozsystemmonitor == 0.3 10:13:57 INFO - moztest == 0.7 10:13:57 INFO - mozversion == 1.4 10:13:57 INFO - psutil == 3.1.1 10:13:57 INFO - requests == 1.2.3 10:13:57 INFO - wsgiref == 0.1.2 10:13:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:57 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')]} 10:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:57 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')]} 10:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:57 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 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13:57 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 10:13:57 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 10:13:57 INFO - Using env: {'DISPLAY': ':0', 10:13:57 INFO - 'HOME': '/home/cltbld', 10:13:57 INFO - 'LANG': 'en_US.UTF-8', 10:13:57 INFO - 'LANGUAGE': 'en_US:en', 10:13:57 INFO - 'LOGNAME': 'cltbld', 10:13:57 INFO - 'MAIL': '/var/mail/cltbld', 10:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:57 INFO - 'MOZ_NO_REMOTE': '1', 10:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:57 INFO - 'NO_EM_RESTART': '1', 10:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:57 INFO - 'PWD': '/builds/slave/test', 10:13:57 INFO - 'SHELL': '/bin/bash', 10:13:57 INFO - 'SHLVL': '1', 10:13:57 INFO - 'TERM': 'linux', 10:13:57 INFO - 'TMOUT': '86400', 10:13:57 INFO - 'USER': 'cltbld', 10:13:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:57 INFO - '_': '/tools/buildbot/bin/python'} 10:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 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)) 10:13:58 INFO - Cleaning up... 10:13:58 INFO - Return code: 0 10:13:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13: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', 'jsonschema'] in /builds/slave/test/build 10:13: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 jsonschema 10:13:58 INFO - Using env: {'DISPLAY': ':0', 10:13:58 INFO - 'HOME': '/home/cltbld', 10:13:58 INFO - 'LANG': 'en_US.UTF-8', 10:13:58 INFO - 'LANGUAGE': 'en_US:en', 10:13:58 INFO - 'LOGNAME': 'cltbld', 10:13:58 INFO - 'MAIL': '/var/mail/cltbld', 10:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:58 INFO - 'MOZ_NO_REMOTE': '1', 10:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:58 INFO - 'NO_EM_RESTART': '1', 10:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:58 INFO - 'PWD': '/builds/slave/test', 10:13:58 INFO - 'SHELL': '/bin/bash', 10:13:58 INFO - 'SHLVL': '1', 10:13:58 INFO - 'TERM': 'linux', 10:13:58 INFO - 'TMOUT': '86400', 10:13:58 INFO - 'USER': 'cltbld', 10:13:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:58 INFO - '_': '/tools/buildbot/bin/python'} 10:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:13:58 INFO - Cleaning up... 10:13:58 INFO - Return code: 0 10:13:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f655c167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', '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 10:13: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', 'flake8'] in /builds/slave/test/build 10:13: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 flake8 10:13:58 INFO - Using env: {'DISPLAY': ':0', 10:13:58 INFO - 'HOME': '/home/cltbld', 10:13:58 INFO - 'LANG': 'en_US.UTF-8', 10:13:58 INFO - 'LANGUAGE': 'en_US:en', 10:13:58 INFO - 'LOGNAME': 'cltbld', 10:13:58 INFO - 'MAIL': '/var/mail/cltbld', 10:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:58 INFO - 'MOZ_NO_REMOTE': '1', 10:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:58 INFO - 'NO_EM_RESTART': '1', 10:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:58 INFO - 'PWD': '/builds/slave/test', 10:13:58 INFO - 'SHELL': '/bin/bash', 10:13:58 INFO - 'SHLVL': '1', 10:13:58 INFO - 'TERM': 'linux', 10:13:58 INFO - 'TMOUT': '86400', 10:13:58 INFO - 'USER': 'cltbld', 10:13:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:58 INFO - '_': '/tools/buildbot/bin/python'} 10:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:58 INFO - Downloading/unpacking flake8 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:14:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:14:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:14:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:01 INFO - no previously-included directories found matching 'docs/_build' 10:14:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:14:01 INFO - Running setup.py install for pep8 10:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:01 INFO - no previously-included directories found matching 'docs/_build' 10:14:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:14:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:14:01 INFO - Cleaning up... 10:14:01 INFO - Return code: 0 10:14:01 INFO - Running post-action listener: _resource_record_post_action 10:14:01 INFO - Running post-action listener: _start_resource_monitoring 10:14:01 INFO - Starting resource monitoring. 10:14:01 INFO - ##### 10:14:01 INFO - ##### Finished create-virtualenv step (success) 10:14:01 INFO - ##### 10:14:01 INFO - ##### 10:14:01 INFO - ##### Running install step. 10:14:01 INFO - ##### 10:14:01 INFO - Running pre-action listener: _resource_record_pre_action 10:14:01 INFO - Running main action method: install 10:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:01 INFO - Reading from file tmpfile_stdout 10:14:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:01 INFO - Reading from file tmpfile_stdout 10:14:01 INFO - Output received: 10:14:01 INFO - Usage: mozinstall [options] installer 10:14:01 INFO - Options: 10:14:01 INFO - -h, --help show this help message and exit 10:14:01 INFO - -d DEST, --destination=DEST 10:14:01 INFO - Directory to install application into. [default: 10:14:01 INFO - "/builds/slave/test"] 10:14:01 INFO - --app=APP Application being installed. [default: firefox] 10:14:01 INFO - mkdir: /builds/slave/test/build/application 10:14:01 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'] 10:14:01 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 10:14:18 INFO - Reading from file tmpfile_stdout 10:14:18 INFO - Output received: 10:14:18 INFO - /builds/slave/test/build/application/firefox/firefox 10:14:18 INFO - Running post-action listener: _resource_record_post_action 10:14:18 INFO - ##### 10:14:18 INFO - ##### Finished install step (success) 10:14:18 INFO - ##### 10:14:18 INFO - ##### 10:14:18 INFO - ##### Running run-tests step. 10:14:18 INFO - ##### 10:14:18 INFO - Running pre-action listener: _resource_record_pre_action 10:14:18 INFO - Running main action method: run_tests 10:14:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:18 INFO - Python 2.7.3 10:14:18 INFO - Return code: 0 10:14:18 INFO - grabbing minidump binary from tooltool 10:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:18 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 0x14762e0>, '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 0x13e2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:18 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 10:14:18 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 10:14:18 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 10:14:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:19 INFO - Return code: 0 10:14:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:14:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:14:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:14:19 INFO - Return code: 0 10:14:19 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/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 10:14:19 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/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 10:14:19 INFO - Using env: {'DISPLAY': ':0', 10:14:19 INFO - 'HOME': '/home/cltbld', 10:14:19 INFO - 'LANG': 'en_US.UTF-8', 10:14:19 INFO - 'LANGUAGE': 'en_US:en', 10:14:19 INFO - 'LOGNAME': 'cltbld', 10:14:19 INFO - 'MAIL': '/var/mail/cltbld', 10:14:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:19 INFO - 'MOZ_NO_REMOTE': '1', 10:14:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:19 INFO - 'NO_EM_RESTART': '1', 10:14:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:19 INFO - 'PWD': '/builds/slave/test', 10:14:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:19 INFO - 'SHELL': '/bin/bash', 10:14:19 INFO - 'SHLVL': '1', 10:14:19 INFO - 'TERM': 'linux', 10:14:19 INFO - 'TMOUT': '86400', 10:14:19 INFO - 'USER': 'cltbld', 10:14:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915', 10:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:19 INFO - '_': '/tools/buildbot/bin/python'} 10:14:19 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/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 10:14:20 INFO - mozversion application_buildid: 20160624073140 10:14:20 INFO - mozversion application_changeset: a277f3e065d2a4026a6c10d2dae02699ef30a504 10:14:20 INFO - mozversion application_display_name: Nightly 10:14:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:20 INFO - mozversion application_name: Firefox 10:14:20 INFO - mozversion application_remotingname: firefox 10:14:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:14:20 INFO - mozversion application_vendor: Mozilla 10:14:20 INFO - mozversion application_version: 50.0a1 10:14:20 INFO - mozversion platform_buildid: 20160624073140 10:14:20 INFO - mozversion platform_changeset: a277f3e065d2a4026a6c10d2dae02699ef30a504 10:14:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:14:20 INFO - mozversion platform_version: 50.0a1 10:14:20 INFO - using testdate: 1466788460 10:14:20 INFO - actual date: 1466788460 10:14:20 INFO - starting webserver on 'localhost:55619' 10:14:20 INFO - SUITE-START | Running 2 tests 10:14:20 INFO - TEST-START | dromaeo_css 10:14:20 INFO - operating with platform_type : linux_ 10:14:20 INFO - Initialising browser for dromaeo_css test... 10:14:20 INFO - TEST-INFO | started process 4466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQE43YB/profile http://localhost:55619/getInfo.html) 10:14:24 INFO - PROCESS | 4466 | __metrics Screen width/height:1600/1200 10:14:24 INFO - PROCESS | 4466 | colorDepth:24 10:14:24 INFO - PROCESS | 4466 | Browser inner width/height: 1024/697 10:14:24 INFO - PROCESS | 4466 | __metrics 10:14:25 ERROR - PROCESS | 4466 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:14:26 INFO - TEST-INFO | 4466: exit 0 10:14:26 INFO - Browser initialized. 10:14:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:26 INFO - TEST-INFO | started process 4583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQE43YB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:38 INFO - PROCESS | 4583 | RSS: Main: 184897536 10:14:38 INFO - PROCESS | 4583 | 10:15:28 INFO - PROCESS | 4583 | 1466788527993 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] 10:17:35 INFO - PROCESS | 4583 | Cycle 1(1): loaded http://localhost:55619/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55619/tests/dromaeo/cssquery-ext.html) 10:17:36 INFO - PROCESS | 4583 | RSS: Main: 188264448 10:17:36 INFO - PROCESS | 4583 | 10:20:38 INFO - PROCESS | 4583 | Cycle 1(1): loaded http://localhost:55619/tests/dromaeo/cssquery-ext.html (next: http://localhost:55619/tests/dromaeo/cssquery-jquery.html) 10:20:39 INFO - PROCESS | 4583 | RSS: Main: 187412480 10:20:39 INFO - PROCESS | 4583 | 10:23:41 INFO - PROCESS | 4583 | Cycle 1(1): loaded http://localhost:55619/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55619/tests/dromaeo/cssquery-mootools.html) 10:23:41 INFO - PROCESS | 4583 | RSS: Main: 188850176 10:23:41 INFO - PROCESS | 4583 | 10:26:43 INFO - PROCESS | 4583 | Cycle 1(1): loaded http://localhost:55619/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55619/tests/dromaeo/cssquery-prototype.html) 10:26:44 INFO - PROCESS | 4583 | RSS: Main: 186376192 10:26:44 INFO - PROCESS | 4583 | 10:29:46 INFO - PROCESS | 4583 | Cycle 1(1): loaded http://localhost:55619/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55619/tests/dromaeo/cssquery-yui.html) 10:29:47 INFO - PROCESS | 4583 | RSS: Main: 188403712 10:29:47 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | Cycle 1(1): loaded http://localhost:55619/tests/dromaeo/cssquery-yui.html (next: http://localhost:55619/tests/dromaeo/cssquery-dojo.html) 10:32:50 INFO - PROCESS | 4583 | RSS: Main: 189259776 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | __start_tp_report 10:32:50 INFO - PROCESS | 4583 | _x_x_mozilla_page_load 10:32:50 INFO - PROCESS | 4583 | _x_x_mozilla_page_load_details 10:32:50 INFO - PROCESS | 4583 | |i|pagename|runs| 10:32:50 INFO - PROCESS | 4583 | |0;dojo.html;3049.146239053065;3096.1021303821894;3121.2821051158235;3126.937461250775;3135.388599223151;5329.360476742787;5348.251244825723;5387.19192121182;5421.376541697706;5451;5216.347956505437;5360;5362.731863406833;5366.677999320043;5462.836114916549;4827.25177597473;4859.295402166684;4942.654014219006;4989.276554899538;5021.6735912165595;548.1800491495602;4811.951880481185;4819.44576373718;4885.096257192413;4919.581835543983;4849.102915960559;4864.027194561102;4872.415310162785;4891.144049791273;4933.531314525115;4859.538343857328;4861.392325959255;4873.756312184377;4874.610031197496;4948.703077815343;4730.976345118287;4832.888435659818;4835.468098509161;4876.463589005207;4897.485763994765;5372.462753724635;5374.140137577969;5390.407055223922;5408.486193811582;5444.128939369682;5576.33084029915;5740.1102829061565;5767.33675627304;5772.451617096369;5777.566682498829;5581.10702287632;5591.7483713233005;5625.54995600351;5658.490735833795;5670.092785154397;5266.34170728659;5270.81406683497;5272.4200337963175;5275.709835959021;5279.1817268323475;5589.301337332833;5667.8866422672145;5856.94143058564;5869.7945571904775;5897.32180799205;5631.155326701028;5677.148427735872;5687.03320435527;5725.427457254241;5735.512481439041;5781.855453613609;5782.971085144547;5787;5793.652380857162;5794.768209271582;5587.273654424899;5685.374608793029;5764.365919748824;5769.1923130761725;5769.394213607511;5765.740541675635;5783.913241301384;5795.449432303924;5807.245058142415;5837.824865254049;4332.371806088099;4351.021020270414;4366.148601022834;4376.299792033323;4399.450068741407;3861.343571592836;3889.027743064234;3899.454076429302;3910.393888947218;3950.743201691881;5390.110631745796;5404.1353383459245;5407.810726624628;5416.268803711528;5425.403205647375;5682.318121825408;5715.228444160069;5716.371199168088;5720.542356611461;5722.62802917809;5329.546988505943;5421.756020979065;5447.754851031713;5448.427915068861;5460.836174914759;4953.8266160684925;4978.278149668277;4979.228219625891;4981.551660350586;5053.620978426633;5868.23712917318;5898;5907.645541267538;5933.110033495011;6029.879402411927;5592.189132575672;5723.599348045597;5735.942640573708;5770.653760774199;5781.855453613609;5989.071693887455;5992.67040312787;6035.637861728134;6041.516678665784;6050.42520960508;5652.123920792284;5658.660480371191;5672.659640421588;5701.40135285789;5710.486056254957;5470.17947307907;5701.287339082614;5711.428857114255;5772.9711351442975;5780.364159942319;5592.161175823497;5596.804111856066;5601.5238704710555;5612.522935550524;5620.297462817148;5427.511523962862;5583.134614134816;5584.46947539983;5627.690477023803;5635.605507614428;5388.164834450667;5436.809711660073;5451.56387488992;5479.287692599936;5481.177823326533;5526.834194973996;5538.16927460868;5549.500544950974;5586.916196257141;5607.411221821813;5386.730663466889;5450.509454149145;5468.316460442445;5470.042742520122;5537.141743029837 10:32:50 INFO - PROCESS | 4583 | |1;ext.html;559.602682095712;609.682964858274;611.4466407900851;613.0436519030313;629.8866204083265;42902;44615.10769784606;44731.32903006453;47393.99999999991;47496.287555686606;44879.326810097875;45404;45673.54326456734;45734;45740;8892.866607000884;9064;9069.410488318272;9071.63713451461;9076.092390760905;8876.600552975131;8964;8964.372493925428;8966.417182883124;8971.506567138806;8787.0334263231;8816.647334106628;8851.645934162625;8856.335774816882;8865.95567022164;8899.065598112202;8941.10588941104;8966.686165984225;8970.910290897073;8974.775630609221;8881.111888811067;8919.197272245465;8961.6863409781;8969.192772650427;9005.864912026325;41428.37857432141;42328.576714232775;42424;42578.36132458015;42584.78707606442;3512.227309991798;3749.6062913393976;3808.7143464240294;4040.6363427291685;4042.1713548722737;33183.502247466306;33188.668113318796;33249.501257481155;33661.83169084163;34776.30447391063;4067.1662309226535;4194.035371864457;4230.682698797603;4311.07311927937;4320.30875059992;338615;340433;341376;341659;344233;34310.65689343074;35665.46501802475;57674.423255767746;58243.417565824646;58561;36520.81739591285;37055.814720926224;37129;37253;37258.813705931294;15705.450309239122;15946;15954.361825527081;15992.840071599368;16003.359865605478;13298.667533311746;13364.465421383231;13428.664283392993;13457.596272111852;13518.053736238566;8327.875081873777;8390.958045209734;8462.280706140047;8483.830323393497;8510.191531804468;3233.3048394595276;3249.2056831125215;3283.6387997320276;3340.098173493192;3367;1023.6775415744165;1033.4471057984092;1055.055725126008;1101.9393933333583;1111.6498303034518;33125.33749325;33376;33443.996680099146;33469.330613387596;33583.83208083944;1090.2695194219734;1095.8411030400548;1115.0912006714502;1148.592249751343;1160.3328086350382;17089.658206835793;17198;17318.740218896728;17346.65306693859;17454.12729363527;562730;566374;566593;568127;570355;57751;58661;58833;59054.70472647609;59099.704501477216;1311.7376524695098;1316.2365827819842;1339.9665008374673;1350.5273154395884;1350.7906274527268;31048;32066.358672825947;32332.515012275304;32610;33112.834435827666;51269;55003;57303.42696572981;57449;59528;387952;388992;390190;390706;393173;42422;42975.57024429716;42998.570014299454;43025.139497210504;43590.56409435992;47580.52419475761;47956.5204347952;48440.75779621079;48821.511784883114;49243.753781230866;40186.39720404255;41001.51487123628;41430.585694142675;41679.1664166721;41903.58096418997;39920.60079399169;40676.3898541528;40800.1839963205;40838.387424189255;40935.7953210232;39643.405348920365;40926.38610420906;42520.36219456772;42763;44931.77534112439;33953.32093358169;37045.25909481741;37377.252454950205;39357.212855743295;39576.40635390529;28802.567961480174;28825;28827.855860720563;29210.56184157197;29468 10:32:50 INFO - PROCESS | 4583 | |2;jquery.html;375.1914623985312;384.20277923309123;392.0727479510956;399.34706754456494;414.45292214277146;13838.169709817417;18166;18563.443096707088;19689.704654430196;19777.208911643535;18249.452516424528;18646.53383665409;18996.430107096774;19629.50926226845;19722.605547889034;5364.81973965727;5620.887582248373;5741.368449470555;5752.741126649311;5754.7339585291165;5334.653247538917;5610.747516361753;5615.943840561604;5648.548116150698;5671.120976248688;5611.3546942101775;5624.0439125348585;5648.774049038034;5674.773009079632;5702.287214098238;6154.938450615504;6282.780102696406;6329.430351268385;6446.580972236837;6471;5671.291088613923;5720.570957178228;5723.856903577403;5740.942590574083;5741.799037033684;21735.565288694295;22474.213402530997;22684.206052788075;22758.65862012071;23160.305190844134;2384.284714585617;2385.7614238576175;2402.2553008567224;2405.410674384787;2457.361086117622;10165.339252948535;10182.847257291147;10374.066334029974;10471;10608.416537090457;1797.1373740604452;1852.6016906365196;1876.7466392037172;1891.1206289075647;1989.4926793667667;61214.38785612176;69087.30912690859;69756.6512167441;75914.24085759127;80367.59816200881;10637.361758294372;10710.03609675133;10918.434167970521;10979.505922233358;10987.450627468595;14853.777193342108;14977.625559360886;14990.47533336328;15082.773758393632;15084.321205545777;8103.635336409876;8471.703490377931;8521.147885211552;8545.67265812829;8595.613197406132;8092.109867914524;8157.347412207009;8295.668173273001;8397.244248017707;8430.83138337242;4476.4180656514445;4520.864374068783;4535.31970204472;4608.078384323148;4645.837395691135;1972.4477146398744;1977.3079422202113;1992.9806343389776;2005.31819181479;2051.8974051297378;463.92809114587294;980.2794945714894;1004.2217281606813;1011.2415688233824;1092.5247517329988;11128.332300062022;12270;12288.078394120297;12338.938305308595;12414.75170496585;480.5434836904954;493.97036177829443;496.9875753106201;503.62228328753434;514.2389263889464;6539.6403197824575;6579.30917253691;6582.605043697394;6631.30371311015;6670;506967;513992;516699;533139;540340;82814;103734.48132759288;104523;105155.4742226284;105738.4713076445;1005.8189525885265;1017.8066167428165;1029.7528593137743;1052.221356196409;1069.6630561373297;17500.299988000846;17853;18119.637607248045;18192.81807181911;18234.635307293516;39083;41905;42232.36651450292;43275.13449730925;43425;59860;59903.1014534791;60418;61117.38882611117;61332;7607.277308655669;8033.397495187767;8583.699570515002;8710.346723995599;8968.192862642394;7867.724629637935;13910.930445347709;14077.648058798612;14172.858271417153;14204.28978551089;11212.83180752273;11792.823107653221;11997.580084696994;12092.274463532216;12101.939490302491;12292.385380731106;12476.313802740937;12478.5008599655;12568.183068100545;12569.93715031419;11675.124365672438;11779.646610601696;12754.298513581842;12835.165714228546;13054.34728263602;8413.326933845156;8977.955110224408;9088.59101340428;9097;12440.75118497643;12703.110782245154;12757.107002509736;12860.807087893876;12961.22232666043;13512.6621834451 10:32:50 INFO - PROCESS | 4583 | |3;mootools.html;1427.1294510348685;1457.060196173468;1525.6262215757142;1678.4712815463135;1682.512071499266;7565.886511702329;8029.879551806727;8110.837783244331;8639.956800215998;8661.653533858645;8195.057568379638;8296.585170741453;8385.832283354344;8418.789530261747;8434.072252052269;2217.84475086744;2225.376894469551;2244.652078927769;2254.0195015168456;2254.875981820999;2202.119152339061;2222.0334154642783;2240.5070884405404;2245.3376254005107;2249.9987505560034;2207.5033117548583;2207.7350717913873;2212.413710366754;2224.1881713174735;2254.9323520294333;2161.384005558416;2164.6103701333755;2180.367693368921;2180.607490651682;2184.191849015858;2179.814715749163;2197.1540956731615;2201.6147174244443;2206.437358473595;2209.359285807114;8411.957940210259;8437.409381343308;8448;8468.78828029298;8490.957545212234;4782.856514304542;4831.4685384607665;4852.369192005017;4888.169011268057;4896.926546101811;3001.849907504616;3235.773495855291;3343.548620936191;3356.664333566624;3378.2905589826164;1072.5441687282873;1081;1088.0533935476108;1093.049047328821;1109.0628418986025;11690;11733.354665493394;11755.647330580096;11803.996660283887;11826.526938922432;4245.490541135084;4312.008238105253;4388.605025547652;4409.228385032607;4459.219636563588;9898.65354712596;9948.950255248677;9954.900450995397;9961.402315860927;10000.199984001263;5049.141645920203;5049.6212784041345;5057.797688092509;5088.211327244283;5094.286799848024;4133.6693064554765;4563.155816173952;4580.519045500175;4726.220173671306;4727.858164255078;3748.6813620842536;3781.1303400218103;3840.711946604016;3856.267309211241;3987.760734355948;1185.27105829914;1188.1504724122294;1200.6578125234266;1210.1589395370133;1218.5369559567307;820.7989042684461;953.7472569769017;968.7093871838421;985.6106837799173;1019.7756493571402;5581.10702287632;5611.242482264924;5735.311762588432;5737.340205876378;6064.666443345658;900.7477906186278;933.2533972821851;957.200737384278;971.5725080964353;991.5884907763342;4042.8382864685673;4106.568810274938;4112.383142528644;4194.2450358935075;4197.421341958761;10143;10573.894261057445;10576.735581610521;10597.258191926645;10620.575176992988;10416.947915260374;10422.478876056166;10484.056434920894;10494.370337779757;10495.265331426726;7790.298873101448;7906.5651389173;7908.960455197687;7912.841743165104;7915.416916616699;5574.247476590771;5693.743781529758;5762.1068734346245;5778.306603207642;5802.071668533014;9554.331196816156;9559.378640388353;9632.229421646392;9638.373505722106;9729.270304727315;9480.146786788946;9591.520423978913;9963.25275604318;9965.850512242178;9970.800583988135;6540.50946179029;6994;7190.137183538009;7226.421886248982;7375.8156046099275;8240.83518329642;8282.958585207036;8296.70961516344;8351.20663536963;8379.748607541784;7253.673584688596;7269.781906542812;7545.245475452411;7545.773626791205;7683.961580192064;7282.162551306667;7441.62791860394;7499.925000749922;7554.697812087675;7637.121731001006;6683.699233534599;6684.298148694317;6691.966540167463;6711.4966377520905;6751.426128779109;4933.9013219736125;5092;5096.541311282002;5122.513361230677;5238.71187084714;4996.800127994839;5110.284560161655;5173.689578625144;5244.580433565382;5255.185446255837 10:32:50 INFO - PROCESS | 4583 | |4;prototype.html;313.5406629288093;315.99368012639763;319.74260720120293;336.46837995966376;337.65221821523824;5436.728163591824;5487.451254874511;5513.3108361454815;5560.9165862512045;5669.659820410773;5619.466150715686;5620.550355971523;5620.606557540964;5630.887382252363;5648.406917273689;4304.7632380219075;4342.348647702838;4344.370066340379;4359.8692039238795;4368.213721530124;4106.993786522291;4279.74321540707;4344.913101737963;4364.367166760818;4395.132068870733;4268.274393353122;4350.36919646651;4357.673174511909;4409.29451287794;4415.425994620711;4395.934060989071;4398.208322501932;4406.272964960777;4408.757518336491;4432.955670443319;3817.015152120882;3873.341531939577;3893.493845800056;3904.726669133162;3908.5309762828642;5411.83764487066;5443.482869127427;5461.344638643349;5467.617266791326;5467.863303417406;5043.3191519145175;5072.949270507284;5073.7209453480045;5074.412049854601;5096.9041656043755;5661.1508273758855;5876.61801982874;5884.264466941632;5907.822765317047;5918.7928422505;4261.3607958806115;4271.9359209611885;4296.5273819879785;4297.570242975708;4318.330658747867;5993.280806303272;6012.3085845127935;6059.333473317932;6059.939400605982;6138.7237574309265;4261.97869010653;4381.342798580238;4390.846320378771;4396.736195828261;4398.494173170063;4433.401490798766;4441;4472.105578884236;4476.395686582269;4480.596746292849;5065.290859279704;5069.112905241568;5074.391073071255;5092.592592592584;5092.8472145835685;5677.205191273225;5765.365809760923;5849.298084229835;5884.676342801187;6016.939830601726;1515.1590867068662;1529.3806008566548;1531.2420351925869;1534.4015833824817;1536.6004838741785;952.766572189804;958.7746879483316;968.4673429613684;969.2778879734643;980.1668581705493;5048.939722658283;5083.237514372874;5093.9490605094215;5107.90575863894;5135.486451354909;5322.536302516762;5323.908598737249;5342.519173274346;5342.759575819097;5366.543843773323;4770.570648641639;4960.652754307236;5022.475454437905;5052.863105801165;5100.336956195671;2839.4037252177272;2858.8713507892194;2865.0831733845384;2894.435585060893;2900.303927057491;5445.537129343971;5472.318563903738;5515.586331025189;5557.5553955683445;5563.5271001964475;5402.972985135049;5682.7782026864425;6208.354785981718;6228.626282423069;6259.342769009279;6286.339934306832;6308.684565771693;6349.2698339690605;6366.204224471941;6388.361163883667;6048.637081774931;6095.769242301587;6121.204243448323;6130.570860039755;6152.169457123231;6031.4064952069275;6043.848903777441;6052.969735151296;6065.8474889770805;6085.4523092921845;6108.144859719554;6355.841103972438;6356.237251529846;6371.808845734636;6379.617222966637;4225.809838557334;4237.851675191477;4240.045989652303;4255.893602659959;4290.699651024398;5872.94127058741;5904.291485021653;6073.210482637229;6179.671370655331;6190.845228869314;5854.970725146517;5895.823125306248;5901.734421950937;5921.289445266596;5960.5231581474245;5923.763049477972;5931.584789064724;5950.851228719317;5961.791337303173;5991.191189189578;5656.717164141859;5831.475167234969;5851.882962340815;5855.882882342415;5861.706914654335;5977.9103313451205;5989.263113696979;6020.4280593343565;6034.517238620988;6061.181740464981;5740.856478588069;5872.324682661549;5872.970635146968;5874.471297583238;5883.852903677443 10:32:50 INFO - PROCESS | 4583 | |5;yui.html;731.5354749733917;757.4886951307866;775.4145620056856;810.3233799777186;830.7715378270976;14467;15542;15551;15605;15609;14147.292635368241;14513.927430362859;14525.636859078528;14532.564023079298;14552;782.4444644302538;786.0410299434709;800.131856935223;803.6945960534988;818.5088946632033;795.6300320351036;795.8726603743402;796.9721059762909;799.9040115186186;802.3821657323857;844.4637655089001;846.3483117999137;847.6482259862149;850.2390360627235;850.7617866997219;830.8255266394065;841.7222316635496;842.6208206307186;843.1315744782884;844.0588743550958;615.827568280882;615.9784407545759;616.6762449713937;618.0389494336305;618.1438707390251;13950.441982320695;14083.788743168861;14094.71810563783;14109.223992680398;14123.081999670092;15007.624809379744;15400.691986160215;15429.768553471707;15547.14490703011;15645.295961681752;11842.763144737142;11924.46339914706;12050.517979280818;12153.116266978544;12546.247225166519;3917.5690674025836;3918.8236529356245;4025.376066709665;4079.694022948261;4085.734427262248;78842.60578697127;80072.79890801701;80229.19770802333;80241;81341;12007.594444693717;12110.152289339661;12171.208871423329;12297.139200255897;12410.937945310396;22932.197373092196;23050.884745576164;23113.537729245658;23132.537349253256;23199.884000580227;8586.65653373858;8602.440841345293;8686.218240358397;8793.516356600448;8810.823783524422;4744.5729884309885;4784.378030855966;4825.131476334223;4869.853904382803;4912.312276281324;3776.716746243988;3934.6655534279907;3948.6841052715713;3949.7235193536753;3961.1285517186175;649.9535747446607;652.8433176037717;668.913041304637;703.3601114233921;744.4714252880407;692.1244625548685;727.4526784609675;733.886247631618;745.6271864067966;794.9466956282948;9698.515074246401;9985.500724963722;10220.233482488844;10446.68659940203;10466.499405255812;708.6598432752205;729.8503806719609;736.3704033051664;740.4372676765589;765.479473957703;4848.357958963909;4995;4998.025385049953;5005.27423523587;5016.072026675077;118256.40871795759;118639;120190.39904800594;120975;123188.99271547321;96522;97594;97775;97868;97989;56639.71680141655;74868.62565687137;83193.58403207945;86558;87248.12751872528;10007.035963253356;10336.844947325946;10362.792744145225;10459.215558832966;10819.945900270448;36580.45129323009;49596;50064;53963.11004856053;54890.17664734952;70340.64829676024;73864.26135738574;77415.2258477408;77592.61203693945;78620.60689696515;12949.611511654666;13073.738525229252;13144.868551314747;13445.663858403226;13848.30758462093;14789.482368117064;15039;15251.161186134868;15279.465218717292;15940.043597384194;14535.709285814435;14634;14673.339699713326;14778.77831832502;15190.392384304503;14159.575212743222;14162.362693678602;14451.49419770303;14463.204523750874;14851.925740371229;14042.719145617235;14163.575092746822;14458.421663133357;14617.415303387745;14698.779518307449;10441.843372349573;11133.387663678575;11755.764884702428;11859.703507412383;11968.16222864391;10132.544035518567;11009.229353945148;11099.889001109885;11147.609833655782;11183.832242516532 10:32:50 INFO - PROCESS | 4583 | __end_tp_report 10:32:50 INFO - PROCESS | 4583 | __start_cc_report 10:32:50 INFO - PROCESS | 4583 | _x_x_mozilla_cycle_collect,373 10:32:50 INFO - PROCESS | 4583 | __end_cc_report 10:32:50 INFO - PROCESS | 4583 | __startTimestamp1466789570413__endTimestamp 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | ------- Summary: start ------- 10:32:50 INFO - PROCESS | 4583 | Number of tests: 6 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | [#0] dojo.html Cycles:165 Average:5292.32 Median:5470.18 stddev:707.37 (12.9%) stddev-sans-first:687.31 10:32:50 INFO - PROCESS | 4583 | Values: 3049.1 3096.1 3121.3 3126.9 3135.4 5329.4 5348.3 5387.2 5421.4 5451.0 5216.3 5360.0 5362.7 5366.7 5462.8 4827.3 4859.3 4942.7 4989.3 5021.7 548.2 4812.0 4819.4 4885.1 4919.6 4849.1 4864.0 4872.4 4891.1 4933.5 4859.5 4861.4 4873.8 4874.6 4948.7 4731.0 4832.9 4835.5 4876.5 4897.5 5372.5 5374.1 5390.4 5408.5 5444.1 5576.3 5740.1 5767.3 5772.5 5777.6 5581.1 5591.7 5625.5 5658.5 5670.1 5266.3 5270.8 5272.4 5275.7 5279.2 5589.3 5667.9 5856.9 5869.8 5897.3 5631.2 5677.1 5687.0 5725.4 5735.5 5781.9 5783.0 5787.0 5793.7 5794.8 5587.3 5685.4 5764.4 5769.2 5769.4 5765.7 5783.9 5795.4 5807.2 5837.8 4332.4 4351.0 4366.1 4376.3 4399.5 3861.3 3889.0 3899.5 3910.4 3950.7 5390.1 5404.1 5407.8 5416.3 5425.4 5682.3 5715.2 5716.4 5720.5 5722.6 5329.5 5421.8 5447.8 5448.4 5460.8 4953.8 4978.3 4979.2 4981.6 5053.6 5868.2 5898.0 5907.6 5933.1 6029.9 5592.2 5723.6 5735.9 5770.7 5781.9 5989.1 5992.7 6035.6 6041.5 6050.4 5652.1 5658.7 5672.7 5701.4 5710.5 5470.2 5701.3 5711.4 5773.0 5780.4 5592.2 5596.8 5601.5 5612.5 5620.3 5427.5 5583.1 5584.5 5627.7 5635.6 5388.2 5436.8 5451.6 5479.3 5481.2 5526.8 5538.2 5549.5 5586.9 5607.4 5386.7 5450.5 5468.3 5470.0 5537.1 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | [#1] ext.html Cycles:180 Average:59128.58 Median:40968.66 stddev:117789.00 (287.5%) stddev-sans-first:118037.34 10:32:50 INFO - PROCESS | 4583 | Values: 559.6 609.7 611.4 613.0 629.9 42902.0 44615.1 44731.3 47394.0 47496.3 44879.3 45404.0 45673.5 45734.0 45740.0 8892.9 9064.0 9069.4 9071.6 9076.1 8876.6 8964.0 8964.4 8966.4 8971.5 8787.0 8816.6 8851.6 8856.3 8866.0 8899.1 8941.1 8966.7 8970.9 8974.8 8881.1 8919.2 8961.7 8969.2 9005.9 41428.4 42328.6 42424.0 42578.4 42584.8 3512.2 3749.6 3808.7 4040.6 4042.2 33183.5 33188.7 33249.5 33661.8 34776.3 4067.2 4194.0 4230.7 4311.1 4320.3 338615.0 340433.0 341376.0 341659.0 344233.0 34310.7 35665.5 57674.4 58243.4 58561.0 36520.8 37055.8 37129.0 37253.0 37258.8 15705.5 15946.0 15954.4 15992.8 16003.4 13298.7 13364.5 13428.7 13457.6 13518.1 8327.9 8391.0 8462.3 8483.8 8510.2 3233.3 3249.2 3283.6 3340.1 3367.0 1023.7 1033.4 1055.1 1101.9 1111.6 33125.3 33376.0 33444.0 33469.3 33583.8 1090.3 1095.8 1115.1 1148.6 1160.3 17089.7 17198.0 17318.7 17346.7 17454.1 562730.0 566374.0 566593.0 568127.0 570355.0 57751.0 58661.0 58833.0 59054.7 59099.7 1311.7 1316.2 1340.0 1350.5 1350.8 31048.0 32066.4 32332.5 32610.0 33112.8 51269.0 55003.0 57303.4 57449.0 59528.0 387952.0 388992.0 390190.0 390706.0 393173.0 42422.0 42975.6 42998.6 43025.1 43590.6 47580.5 47956.5 48440.8 48821.5 49243.8 40186.4 41001.5 41430.6 41679.2 41903.6 39920.6 40676.4 40800.2 40838.4 40935.8 39643.4 40926.4 42520.4 42763.0 44931.8 33953.3 37045.3 37377.3 39357.2 39576.4 28802.6 28825.0 28827.9 29210.6 29468.0 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | [#2] jquery.html Cycles:180 Average:29687.58 Median:2431.39 stddev:86088.00 (3540.7%) stddev-sans-first:86301.36 10:32:50 INFO - PROCESS | 4583 | Values: 375.2 384.2 392.1 399.3 414.5 13838.2 18166.0 18563.4 19689.7 19777.2 18249.5 18646.5 18996.4 19629.5 19722.6 5364.8 5620.9 5741.4 5752.7 5754.7 5334.7 5610.7 5615.9 5648.5 5671.1 5611.4 5624.0 5648.8 5674.8 5702.3 6154.9 6282.8 6329.4 6446.6 6471.0 5671.3 5720.6 5723.9 5740.9 5741.8 21735.6 22474.2 22684.2 22758.7 23160.3 2384.3 2385.8 2402.3 2405.4 2457.4 10165.3 10182.8 10374.1 10471.0 10608.4 1797.1 1852.6 1876.7 1891.1 1989.5 61214.4 69087.3 69756.7 75914.2 80367.6 10637.4 10710.0 10918.4 10979.5 10987.5 14853.8 14977.6 14990.5 15082.8 15084.3 8103.6 8471.7 8521.1 8545.7 8595.6 8092.1 8157.3 8295.7 8397.2 8430.8 4476.4 4520.9 4535.3 4608.1 4645.8 1972.4 1977.3 1993.0 2005.3 2051.9 463.9 980.3 1004.2 1011.2 1092.5 11128.3 12270.0 12288.1 12338.9 12414.8 480.5 494.0 497.0 503.6 514.2 6539.6 6579.3 6582.6 6631.3 6670.0 506967.0 513992.0 516699.0 533139.0 540340.0 82814.0 103734.5 104523.0 105155.5 105738.5 1005.8 1017.8 1029.8 1052.2 1069.7 17500.3 17853.0 18119.6 18192.8 18234.6 39083.0 41905.0 42232.4 43275.1 43425.0 59860.0 59903.1 60418.0 61117.4 61332.0 7607.3 8033.4 8583.7 8710.3 8968.2 7867.7 13910.9 14077.6 14172.9 14204.3 11212.8 11792.8 11997.6 12092.3 12101.9 12292.4 12476.3 12478.5 12568.2 12569.9 11675.1 11779.6 12754.3 12835.2 13054.3 8413.3 8978.0 9088.6 9097.0 12440.8 12703.1 12757.1 12860.8 12961.2 13512.7 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | [#3] mootools.html Cycles:180 Average:5572.24 Median:5053.71 stddev:3151.81 (62.4%) stddev-sans-first:3145.25 10:32:50 INFO - PROCESS | 4583 | Values: 1427.1 1457.1 1525.6 1678.5 1682.5 7565.9 8029.9 8110.8 8640.0 8661.7 8195.1 8296.6 8385.8 8418.8 8434.1 2217.8 2225.4 2244.7 2254.0 2254.9 2202.1 2222.0 2240.5 2245.3 2250.0 2207.5 2207.7 2212.4 2224.2 2254.9 2161.4 2164.6 2180.4 2180.6 2184.2 2179.8 2197.2 2201.6 2206.4 2209.4 8412.0 8437.4 8448.0 8468.8 8491.0 4782.9 4831.5 4852.4 4888.2 4896.9 3001.8 3235.8 3343.5 3356.7 3378.3 1072.5 1081.0 1088.1 1093.0 1109.1 11690.0 11733.4 11755.6 11804.0 11826.5 4245.5 4312.0 4388.6 4409.2 4459.2 9898.7 9949.0 9954.9 9961.4 10000.2 5049.1 5049.6 5057.8 5088.2 5094.3 4133.7 4563.2 4580.5 4726.2 4727.9 3748.7 3781.1 3840.7 3856.3 3987.8 1185.3 1188.2 1200.7 1210.2 1218.5 820.8 953.7 968.7 985.6 1019.8 5581.1 5611.2 5735.3 5737.3 6064.7 900.7 933.3 957.2 971.6 991.6 4042.8 4106.6 4112.4 4194.2 4197.4 10143.0 10573.9 10576.7 10597.3 10620.6 10416.9 10422.5 10484.1 10494.4 10495.3 7790.3 7906.6 7909.0 7912.8 7915.4 5574.2 5693.7 5762.1 5778.3 5802.1 9554.3 9559.4 9632.2 9638.4 9729.3 9480.1 9591.5 9963.3 9965.9 9970.8 6540.5 6994.0 7190.1 7226.4 7375.8 8240.8 8283.0 8296.7 8351.2 8379.7 7253.7 7269.8 7545.2 7545.8 7684.0 7282.2 7441.6 7499.9 7554.7 7637.1 6683.7 6684.3 6692.0 6711.5 6751.4 4933.9 5092.0 5096.5 5122.5 5238.7 4996.8 5110.3 5173.7 5244.6 5255.2 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | [#4] prototype.html Cycles:180 Average:4892.60 Median:5464.48 stddev:1447.91 (26.5%) stddev-sans-first:1410.59 10:32:50 INFO - PROCESS | 4583 | Values: 313.5 316.0 319.7 336.5 337.7 5436.7 5487.5 5513.3 5560.9 5669.7 5619.5 5620.6 5620.6 5630.9 5648.4 4304.8 4342.3 4344.4 4359.9 4368.2 4107.0 4279.7 4344.9 4364.4 4395.1 4268.3 4350.4 4357.7 4409.3 4415.4 4395.9 4398.2 4406.3 4408.8 4433.0 3817.0 3873.3 3893.5 3904.7 3908.5 5411.8 5443.5 5461.3 5467.6 5467.9 5043.3 5072.9 5073.7 5074.4 5096.9 5661.2 5876.6 5884.3 5907.8 5918.8 4261.4 4271.9 4296.5 4297.6 4318.3 5993.3 6012.3 6059.3 6059.9 6138.7 4262.0 4381.3 4390.8 4396.7 4398.5 4433.4 4441.0 4472.1 4476.4 4480.6 5065.3 5069.1 5074.4 5092.6 5092.8 5677.2 5765.4 5849.3 5884.7 6016.9 1515.2 1529.4 1531.2 1534.4 1536.6 952.8 958.8 968.5 969.3 980.2 5048.9 5083.2 5093.9 5107.9 5135.5 5322.5 5323.9 5342.5 5342.8 5366.5 4770.6 4960.7 5022.5 5052.9 5100.3 2839.4 2858.9 2865.1 2894.4 2900.3 5445.5 5472.3 5515.6 5557.6 5563.5 5403.0 5682.8 6208.4 6228.6 6259.3 6286.3 6308.7 6349.3 6366.2 6388.4 6048.6 6095.8 6121.2 6130.6 6152.2 6031.4 6043.8 6053.0 6065.8 6085.5 6108.1 6355.8 6356.2 6371.8 6379.6 4225.8 4237.9 4240.0 4255.9 4290.7 5872.9 5904.3 6073.2 6179.7 6190.8 5855.0 5895.8 5901.7 5921.3 5960.5 5923.8 5931.6 5950.9 5961.8 5991.2 5656.7 5831.5 5851.9 5855.9 5861.7 5977.9 5989.3 6020.4 6034.5 6061.2 5740.9 5872.3 5873.0 5874.5 5883.9 10:32:50 INFO - PROCESS | 4583 | 10:32:50 INFO - PROCESS | 4583 | [#5] yui.html Cycles:180 Average:20977.79 Median:3993.25 stddev:30022.40 (751.8%) stddev-sans-first:30068.13 10:32:50 INFO - PROCESS | 4583 | Values: 731.5 757.5 775.4 810.3 830.8 14467.0 15542.0 15551.0 15605.0 15609.0 14147.3 14513.9 14525.6 14532.6 14552.0 782.4 786.0 800.1 803.7 818.5 795.6 795.9 797.0 799.9 802.4 844.5 846.3 847.6 850.2 850.8 830.8 841.7 842.6 843.1 844.1 615.8 616.0 616.7 618.0 618.1 13950.4 14083.8 14094.7 14109.2 14123.1 15007.6 15400.7 15429.8 15547.1 15645.3 11842.8 11924.5 12050.5 12153.1 12546.2 3917.6 3918.8 4025.4 4079.7 4085.7 78842.6 80072.8 80229.2 80241.0 81341.0 12007.6 12110.2 12171.2 12297.1 12410.9 22932.2 23050.9 23113.5 23132.5 23199.9 8586.7 8602.4 8686.2 8793.5 8810.8 4744.6 4784.4 4825.1 4869.9 4912.3 3776.7 3934.7 3948.7 3949.7 3961.1 650.0 652.8 668.9 703.4 744.5 692.1 727.5 733.9 745.6 794.9 9698.5 9985.5 10220.2 10446.7 10466.5 708.7 729.9 736.4 740.4 765.5 4848.4 4995.0 4998.0 5005.3 5016.1 118256.4 118639.0 120190.4 120975.0 123189.0 96522.0 97594.0 97775.0 97868.0 97989.0 56639.7 74868.6 83193.6 86558.0 87248.1 10007.0 10336.8 10362.8 10459.2 10819.9 36580.5 49596.0 50064.0 53963.1 54890.2 70340.6 73864.3 77415.2 77592.6 78620.6 12949.6 13073.7 13144.9 13445.7 13848.3 14789.5 15039.0 15251.2 15279.5 15940.0 14535.7 14634.0 14673.3 14778.8 15190.4 14159.6 14162.4 14451.5 14463.2 14851.9 14042.7 14163.6 14458.4 14617.4 14698.8 10441.8 11133.4 11755.8 11859.7 11968.2 10132.5 11009.2 11099.9 11147.6 11183.8 10:32:50 INFO - PROCESS | 4583 | -------- Summary: end -------- 10:32:50 INFO - PROCESS | 4583 | 10:32:51 INFO - TEST-INFO | 4583: exit 0 10:32:51 INFO - TEST-OK | dromaeo_css | took 1111108ms 10:32:51 INFO - TEST-START | kraken 10:32:51 INFO - operating with platform_type : linux_ 10:32:51 INFO - Initialising browser for kraken test... 10:32:51 INFO - TEST-INFO | started process 4823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyIKjww/profile http://localhost:55619/getInfo.html) 10:32:55 INFO - PROCESS | 4823 | __metrics Screen width/height:1600/1200 10:32:55 INFO - PROCESS | 4823 | colorDepth:24 10:32:55 INFO - PROCESS | 4823 | Browser inner width/height: 1024/697 10:32:55 INFO - PROCESS | 4823 | __metrics 10:32:56 ERROR - PROCESS | 4823 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:32:57 INFO - TEST-INFO | 4823: exit 0 10:32:57 INFO - Browser initialized. 10:32:57 INFO - Running cycle 1/1 for kraken test... 10:32:57 INFO - TEST-INFO | started process 4945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyIKjww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:09 INFO - PROCESS | 4945 | RSS: Main: 184963072 10:33:09 INFO - PROCESS | 4945 | 10:33:12 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55619/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:12 INFO - PROCESS | 4945 | RSS: Main: 190316544 10:33:12 INFO - PROCESS | 4945 | 10:33:15 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55619/tests/kraken/driver.html?testName=audio-dft) 10:33:16 INFO - PROCESS | 4945 | RSS: Main: 189329408 10:33:16 INFO - PROCESS | 4945 | 10:33:19 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55619/tests/kraken/driver.html?testName=audio-fft) 10:33:19 INFO - PROCESS | 4945 | RSS: Main: 184168448 10:33:19 INFO - PROCESS | 4945 | 10:33:21 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55619/tests/kraken/driver.html?testName=audio-oscillator) 10:33:22 INFO - PROCESS | 4945 | RSS: Main: 185176064 10:33:22 INFO - PROCESS | 4945 | 10:33:24 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55619/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:25 INFO - PROCESS | 4945 | RSS: Main: 184958976 10:33:25 INFO - PROCESS | 4945 | 10:33:28 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55619/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:29 INFO - PROCESS | 4945 | RSS: Main: 186052608 10:33:29 INFO - PROCESS | 4945 | 10:33:32 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55619/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:33 INFO - PROCESS | 4945 | RSS: Main: 185860096 10:33:33 INFO - PROCESS | 4945 | 10:33:36 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55619/tests/kraken/driver.html?testName=json-parse-financial) 10:33:36 INFO - PROCESS | 4945 | RSS: Main: 185434112 10:33:36 INFO - PROCESS | 4945 | 10:33:38 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55619/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:38 INFO - PROCESS | 4945 | RSS: Main: 185647104 10:33:38 INFO - PROCESS | 4945 | 10:33:40 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:41 INFO - PROCESS | 4945 | RSS: Main: 185655296 10:33:41 INFO - PROCESS | 4945 | 10:33:43 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:44 INFO - PROCESS | 4945 | RSS: Main: 186155008 10:33:44 INFO - PROCESS | 4945 | 10:33:46 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:47 INFO - PROCESS | 4945 | RSS: Main: 186052608 10:33:47 INFO - PROCESS | 4945 | 10:33:50 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:50 INFO - PROCESS | 4945 | RSS: Main: 185892864 10:33:50 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | Cycle 1(1): loaded http://localhost:55619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55619/tests/kraken/driver.html?testName=ai-astar) 10:33:52 INFO - PROCESS | 4945 | RSS: Main: 186957824 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | __start_tp_report 10:33:52 INFO - PROCESS | 4945 | _x_x_mozilla_page_load 10:33:52 INFO - PROCESS | 4945 | _x_x_mozilla_page_load_details 10:33:52 INFO - PROCESS | 4945 | |i|pagename|runs| 10:33:52 INFO - PROCESS | 4945 | |0;ai-astar;102;111;104;109;112;111;112;110;111;111 10:33:52 INFO - PROCESS | 4945 | |1;audio-beat-detection;160;124;151;178;129;158;158;127;189;129 10:33:52 INFO - PROCESS | 4945 | |2;audio-dft;161;162;162;162;172;167;162;166;160;162 10:33:52 INFO - PROCESS | 4945 | |3;audio-fft;76;75;77;152;77;77;76;76;177;77 10:33:52 INFO - PROCESS | 4945 | |4;audio-oscillator;84;85;149;86;85;84;135;85;86;152 10:33:52 INFO - PROCESS | 4945 | |5;imaging-gaussian-blur;118;118;118;118;118;118;119;118;118;117 10:33:52 INFO - PROCESS | 4945 | |6;imaging-darkroom;149;147;147;146;151;149;148;149;148;147 10:33:52 INFO - PROCESS | 4945 | |7;imaging-desaturate;95;97;95;97;96;96;96;95;95;97 10:33:52 INFO - PROCESS | 4945 | |8;json-parse-financial;58;58;57;56;55;56;55;55;62;56 10:33:52 INFO - PROCESS | 4945 | |9;json-stringify-tinderbox;63;62;62;64;63;63;63;63;63;63 10:33:52 INFO - PROCESS | 4945 | |10;stanford-crypto-aes;80;83;80;85;83;79;81;80;146;80 10:33:52 INFO - PROCESS | 4945 | |11;stanford-crypto-ccm;128;131;124;124;121;136;126;135;132;129 10:33:52 INFO - PROCESS | 4945 | |12;stanford-crypto-pbkdf2;171;163;170;162;169;170;165;164;164;162 10:33:52 INFO - PROCESS | 4945 | |13;stanford-crypto-sha256-iterative;68;64;63;63;67;62;67;63;66;63 10:33:52 INFO - PROCESS | 4945 | __end_tp_report 10:33:52 INFO - PROCESS | 4945 | __start_cc_report 10:33:52 INFO - PROCESS | 4945 | _x_x_mozilla_cycle_collect,871 10:33:52 INFO - PROCESS | 4945 | __end_cc_report 10:33:52 INFO - PROCESS | 4945 | __startTimestamp1466789632629__endTimestamp 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | ------- Summary: start ------- 10:33:52 INFO - PROCESS | 4945 | Number of tests: 14 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:2.47 10:33:52 INFO - PROCESS | 4945 | Values: 102.0 111.0 104.0 109.0 112.0 111.0 112.0 110.0 111.0 111.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:158.00 stddev:22.66 (14.3%) stddev-sans-first:23.76 10:33:52 INFO - PROCESS | 4945 | Values: 160.0 124.0 151.0 178.0 129.0 158.0 158.0 127.0 189.0 129.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.00 stddev:3.66 (2.3%) stddev-sans-first:3.76 10:33:52 INFO - PROCESS | 4945 | Values: 161.0 162.0 162.0 162.0 172.0 167.0 162.0 166.0 160.0 162.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.50 stddev:37.63 (49.2%) stddev-sans-first:39.34 10:33:52 INFO - PROCESS | 4945 | Values: 76.0 75.0 77.0 152.0 77.0 77.0 76.0 76.0 177.0 77.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:29.46 (34.7%) stddev-sans-first:30.43 10:33:52 INFO - PROCESS | 4945 | Values: 84.0 85.0 149.0 86.0 85.0 84.0 135.0 85.0 86.0 152.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:33:52 INFO - PROCESS | 4945 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 117.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:1.45 (1.0%) stddev-sans-first:1.50 10:33:52 INFO - PROCESS | 4945 | Values: 149.0 147.0 147.0 146.0 151.0 149.0 148.0 149.0 148.0 147.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 10:33:52 INFO - PROCESS | 4945 | Values: 95.0 97.0 95.0 97.0 96.0 96.0 96.0 95.0 95.0 97.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:2.15 (3.8%) stddev-sans-first:2.24 10:33:52 INFO - PROCESS | 4945 | Values: 58.0 58.0 57.0 56.0 55.0 56.0 55.0 55.0 62.0 56.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 10:33:52 INFO - PROCESS | 4945 | Values: 63.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:80.50 stddev:20.57 (25.6%) stddev-sans-first:21.63 10:33:52 INFO - PROCESS | 4945 | Values: 80.0 83.0 80.0 85.0 83.0 79.0 81.0 80.0 146.0 80.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:130.00 stddev:4.95 (3.8%) stddev-sans-first:5.24 10:33:52 INFO - PROCESS | 4945 | Values: 128.0 131.0 124.0 124.0 121.0 136.0 126.0 135.0 132.0 129.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:167.00 stddev:3.59 (2.1%) stddev-sans-first:3.32 10:33:52 INFO - PROCESS | 4945 | Values: 171.0 163.0 170.0 162.0 169.0 170.0 165.0 164.0 164.0 162.0 10:33:52 INFO - PROCESS | 4945 | 10:33:52 INFO - PROCESS | 4945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:2.17 (3.3%) stddev-sans-first:1.92 10:33:52 INFO - PROCESS | 4945 | Values: 68.0 64.0 63.0 63.0 67.0 62.0 67.0 63.0 66.0 63.0 10:33:52 INFO - PROCESS | 4945 | -------- Summary: end -------- 10:33:52 INFO - PROCESS | 4945 | 10:33:53 INFO - TEST-INFO | 4945: exit 0 10:33:53 INFO - TEST-OK | kraken | took 62387ms 10:33:53 INFO - SUITE-END | took 1173s 10:33:53 INFO - Completed test suite (00:19:33) 10:33:53 INFO - javascript benchmark 10:33:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7191.084440817212, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.146239053065, 3096.1021303821894, 3121.2821051158235, 3126.937461250775, 3135.388599223151, 5329.360476742787, 5348.251244825723, 5387.19192121182, 5421.376541697706, 5451.0, 5216.347956505437, 5360.0, 5362.731863406833, 5366.677999320043, 5462.836114916549, 4827.25177597473, 4859.295402166684, 4942.654014219006, 4989.276554899538, 5021.6735912165595, 548.1800491495602, 4811.951880481185, 4819.44576373718, 4885.096257192413, 4919.581835543983, 4849.102915960559, 4864.027194561102, 4872.415310162785, 4891.144049791273, 4933.531314525115, 4859.538343857328, 4861.392325959255, 4873.756312184377, 4874.610031197496, 4948.703077815343, 4730.976345118287, 4832.888435659818, 4835.468098509161, 4876.463589005207, 4897.485763994765, 5372.462753724635, 5374.140137577969, 5390.407055223922, 5408.486193811582, 5444.128939369682, 5576.33084029915, 5740.1102829061565, 5767.33675627304, 5772.451617096369, 5777.566682498829, 5581.10702287632, 5591.7483713233005, 5625.54995600351, 5658.490735833795, 5670.092785154397, 5266.34170728659, 5270.81406683497, 5272.4200337963175, 5275.709835959021, 5279.1817268323475, 5589.301337332833, 5667.8866422672145, 5856.94143058564, 5869.7945571904775, 5897.32180799205, 5631.155326701028, 5677.148427735872, 5687.03320435527, 5725.427457254241, 5735.512481439041, 5781.855453613609, 5782.971085144547, 5787.0, 5793.652380857162, 5794.768209271582, 5587.273654424899, 5685.374608793029, 5764.365919748824, 5769.1923130761725, 5769.394213607511, 5765.740541675635, 5783.913241301384, 5795.449432303924, 5807.245058142415, 5837.824865254049, 4332.371806088099, 4351.021020270414, 4366.148601022834, 4376.299792033323, 4399.450068741407, 3861.343571592836, 3889.027743064234, 3899.454076429302, 3910.393888947218, 3950.743201691881, 5390.110631745796, 5404.1353383459245, 5407.810726624628, 5416.268803711528, 5425.403205647375, 5682.318121825408, 5715.228444160069, 5716.371199168088, 5720.542356611461, 5722.62802917809, 5329.546988505943, 5421.756020979065, 5447.754851031713, 5448.427915068861, 5460.836174914759, 4953.8266160684925, 4978.278149668277, 4979.228219625891, 4981.551660350586, 5053.620978426633, 5868.23712917318, 5898.0, 5907.645541267538, 5933.110033495011, 6029.879402411927, 5592.189132575672, 5723.599348045597, 5735.942640573708, 5770.653760774199, 5781.855453613609, 5989.071693887455, 5992.67040312787, 6035.637861728134, 6041.516678665784, 6050.42520960508, 5652.123920792284, 5658.660480371191, 5672.659640421588, 5701.40135285789, 5710.486056254957, 5470.17947307907, 5701.287339082614, 5711.428857114255, 5772.9711351442975, 5780.364159942319, 5592.161175823497, 5596.804111856066, 5601.5238704710555, 5612.522935550524, 5620.297462817148, 5427.511523962862, 5583.134614134816, 5584.46947539983, 5627.690477023803, 5635.605507614428, 5388.164834450667, 5436.809711660073, 5451.56387488992, 5479.287692599936, 5481.177823326533, 5526.834194973996, 5538.16927460868, 5549.500544950974, 5586.916196257141, 5607.411221821813, 5386.730663466889, 5450.509454149145, 5468.316460442445, 5470.042742520122, 5537.141743029837], "value": 5246.698884606314, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.602682095712, 609.682964858274, 611.4466407900851, 613.0436519030313, 629.8866204083265, 42902.0, 44615.10769784606, 44731.32903006453, 47393.99999999991, 47496.287555686606, 44879.326810097875, 45404.0, 45673.54326456734, 45734.0, 45740.0, 8892.866607000884, 9064.0, 9069.410488318272, 9071.63713451461, 9076.092390760905, 8876.600552975131, 8964.0, 8964.372493925428, 8966.417182883124, 8971.506567138806, 8787.0334263231, 8816.647334106628, 8851.645934162625, 8856.335774816882, 8865.95567022164, 8899.065598112202, 8941.10588941104, 8966.686165984225, 8970.910290897073, 8974.775630609221, 8881.111888811067, 8919.197272245465, 8961.6863409781, 8969.192772650427, 9005.864912026325, 41428.37857432141, 42328.576714232775, 42424.0, 42578.36132458015, 42584.78707606442, 3512.227309991798, 3749.6062913393976, 3808.7143464240294, 4040.6363427291685, 4042.1713548722737, 33183.502247466306, 33188.668113318796, 33249.501257481155, 33661.83169084163, 34776.30447391063, 4067.1662309226535, 4194.035371864457, 4230.682698797603, 4311.07311927937, 4320.30875059992, 338615.0, 340433.0, 341376.0, 341659.0, 344233.0, 34310.65689343074, 35665.46501802475, 57674.423255767746, 58243.417565824646, 58561.0, 36520.81739591285, 37055.814720926224, 37129.0, 37253.0, 37258.813705931294, 15705.450309239122, 15946.0, 15954.361825527081, 15992.840071599368, 16003.359865605478, 13298.667533311746, 13364.465421383231, 13428.664283392993, 13457.596272111852, 13518.053736238566, 8327.875081873777, 8390.958045209734, 8462.280706140047, 8483.830323393497, 8510.191531804468, 3233.3048394595276, 3249.2056831125215, 3283.6387997320276, 3340.098173493192, 3367.0, 1023.6775415744165, 1033.4471057984092, 1055.055725126008, 1101.9393933333583, 1111.6498303034518, 33125.33749325, 33376.0, 33443.996680099146, 33469.330613387596, 33583.83208083944, 1090.2695194219734, 1095.8411030400548, 1115.0912006714502, 1148.592249751343, 1160.3328086350382, 17089.658206835793, 17198.0, 17318.740218896728, 17346.65306693859, 17454.12729363527, 562730.0, 566374.0, 566593.0, 568127.0, 570355.0, 57751.0, 58661.0, 58833.0, 59054.70472647609, 59099.704501477216, 1311.7376524695098, 1316.2365827819842, 1339.9665008374673, 1350.5273154395884, 1350.7906274527268, 31048.0, 32066.358672825947, 32332.515012275304, 32610.0, 33112.834435827666, 51269.0, 55003.0, 57303.42696572981, 57449.0, 59528.0, 387952.0, 388992.0, 390190.0, 390706.0, 393173.0, 42422.0, 42975.57024429716, 42998.570014299454, 43025.139497210504, 43590.56409435992, 47580.52419475761, 47956.5204347952, 48440.75779621079, 48821.511784883114, 49243.753781230866, 40186.39720404255, 41001.51487123628, 41430.585694142675, 41679.1664166721, 41903.58096418997, 39920.60079399169, 40676.3898541528, 40800.1839963205, 40838.387424189255, 40935.7953210232, 39643.405348920365, 40926.38610420906, 42520.36219456772, 42763.0, 44931.77534112439, 33953.32093358169, 37045.25909481741, 37377.252454950205, 39357.212855743295, 39576.40635390529, 28802.567961480174, 28825.0, 28827.855860720563, 29210.56184157197, 29468.0], "value": 19349.9607564609, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.1914623985312, 384.20277923309123, 392.0727479510956, 399.34706754456494, 414.45292214277146, 13838.169709817417, 18166.0, 18563.443096707088, 19689.704654430196, 19777.208911643535, 18249.452516424528, 18646.53383665409, 18996.430107096774, 19629.50926226845, 19722.605547889034, 5364.81973965727, 5620.887582248373, 5741.368449470555, 5752.741126649311, 5754.7339585291165, 5334.653247538917, 5610.747516361753, 5615.943840561604, 5648.548116150698, 5671.120976248688, 5611.3546942101775, 5624.0439125348585, 5648.774049038034, 5674.773009079632, 5702.287214098238, 6154.938450615504, 6282.780102696406, 6329.430351268385, 6446.580972236837, 6471.0, 5671.291088613923, 5720.570957178228, 5723.856903577403, 5740.942590574083, 5741.799037033684, 21735.565288694295, 22474.213402530997, 22684.206052788075, 22758.65862012071, 23160.305190844134, 2384.284714585617, 2385.7614238576175, 2402.2553008567224, 2405.410674384787, 2457.361086117622, 10165.339252948535, 10182.847257291147, 10374.066334029974, 10471.0, 10608.416537090457, 1797.1373740604452, 1852.6016906365196, 1876.7466392037172, 1891.1206289075647, 1989.4926793667667, 61214.38785612176, 69087.30912690859, 69756.6512167441, 75914.24085759127, 80367.59816200881, 10637.361758294372, 10710.03609675133, 10918.434167970521, 10979.505922233358, 10987.450627468595, 14853.777193342108, 14977.625559360886, 14990.47533336328, 15082.773758393632, 15084.321205545777, 8103.635336409876, 8471.703490377931, 8521.147885211552, 8545.67265812829, 8595.613197406132, 8092.109867914524, 8157.347412207009, 8295.668173273001, 8397.244248017707, 8430.83138337242, 4476.4180656514445, 4520.864374068783, 4535.31970204472, 4608.078384323148, 4645.837395691135, 1972.4477146398744, 1977.3079422202113, 1992.9806343389776, 2005.31819181479, 2051.8974051297378, 463.92809114587294, 980.2794945714894, 1004.2217281606813, 1011.2415688233824, 1092.5247517329988, 11128.332300062022, 12270.0, 12288.078394120297, 12338.938305308595, 12414.75170496585, 480.5434836904954, 493.97036177829443, 496.9875753106201, 503.62228328753434, 514.2389263889464, 6539.6403197824575, 6579.30917253691, 6582.605043697394, 6631.30371311015, 6670.0, 506967.0, 513992.0, 516699.0, 533139.0, 540340.0, 82814.0, 103734.48132759288, 104523.0, 105155.4742226284, 105738.4713076445, 1005.8189525885265, 1017.8066167428165, 1029.7528593137743, 1052.221356196409, 1069.6630561373297, 17500.299988000846, 17853.0, 18119.637607248045, 18192.81807181911, 18234.635307293516, 39083.0, 41905.0, 42232.36651450292, 43275.13449730925, 43425.0, 59860.0, 59903.1014534791, 60418.0, 61117.38882611117, 61332.0, 7607.277308655669, 8033.397495187767, 8583.699570515002, 8710.346723995599, 8968.192862642394, 7867.724629637935, 13910.930445347709, 14077.648058798612, 14172.858271417153, 14204.28978551089, 11212.83180752273, 11792.823107653221, 11997.580084696994, 12092.274463532216, 12101.939490302491, 12292.385380731106, 12476.313802740937, 12478.5008599655, 12568.183068100545, 12569.93715031419, 11675.124365672438, 11779.646610601696, 12754.298513581842, 12835.165714228546, 13054.34728263602, 8413.326933845156, 8977.955110224408, 9088.59101340428, 9097.0, 12440.75118497643, 12703.110782245154, 12757.107002509736, 12860.807087893876, 12961.22232666043, 13512.6621834451], "value": 8900.396396808377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.1294510348685, 1457.060196173468, 1525.6262215757142, 1678.4712815463135, 1682.512071499266, 7565.886511702329, 8029.879551806727, 8110.837783244331, 8639.956800215998, 8661.653533858645, 8195.057568379638, 8296.585170741453, 8385.832283354344, 8418.789530261747, 8434.072252052269, 2217.84475086744, 2225.376894469551, 2244.652078927769, 2254.0195015168456, 2254.875981820999, 2202.119152339061, 2222.0334154642783, 2240.5070884405404, 2245.3376254005107, 2249.9987505560034, 2207.5033117548583, 2207.7350717913873, 2212.413710366754, 2224.1881713174735, 2254.9323520294333, 2161.384005558416, 2164.6103701333755, 2180.367693368921, 2180.607490651682, 2184.191849015858, 2179.814715749163, 2197.1540956731615, 2201.6147174244443, 2206.437358473595, 2209.359285807114, 8411.957940210259, 8437.409381343308, 8448.0, 8468.78828029298, 8490.957545212234, 4782.856514304542, 4831.4685384607665, 4852.369192005017, 4888.169011268057, 4896.926546101811, 3001.849907504616, 3235.773495855291, 3343.548620936191, 3356.664333566624, 3378.2905589826164, 1072.5441687282873, 1081.0, 1088.0533935476108, 1093.049047328821, 1109.0628418986025, 11690.0, 11733.354665493394, 11755.647330580096, 11803.996660283887, 11826.526938922432, 4245.490541135084, 4312.008238105253, 4388.605025547652, 4409.228385032607, 4459.219636563588, 9898.65354712596, 9948.950255248677, 9954.900450995397, 9961.402315860927, 10000.199984001263, 5049.141645920203, 5049.6212784041345, 5057.797688092509, 5088.211327244283, 5094.286799848024, 4133.6693064554765, 4563.155816173952, 4580.519045500175, 4726.220173671306, 4727.858164255078, 3748.6813620842536, 3781.1303400218103, 3840.711946604016, 3856.267309211241, 3987.760734355948, 1185.27105829914, 1188.1504724122294, 1200.6578125234266, 1210.1589395370133, 1218.5369559567307, 820.7989042684461, 953.7472569769017, 968.7093871838421, 985.6106837799173, 1019.7756493571402, 5581.10702287632, 5611.242482264924, 5735.311762588432, 5737.340205876378, 6064.666443345658, 900.7477906186278, 933.2533972821851, 957.200737384278, 971.5725080964353, 991.5884907763342, 4042.8382864685673, 4106.568810274938, 4112.383142528644, 4194.2450358935075, 4197.421341958761, 10143.0, 10573.894261057445, 10576.735581610521, 10597.258191926645, 10620.575176992988, 10416.947915260374, 10422.478876056166, 10484.056434920894, 10494.370337779757, 10495.265331426726, 7790.298873101448, 7906.5651389173, 7908.960455197687, 7912.841743165104, 7915.416916616699, 5574.247476590771, 5693.743781529758, 5762.1068734346245, 5778.306603207642, 5802.071668533014, 9554.331196816156, 9559.378640388353, 9632.229421646392, 9638.373505722106, 9729.270304727315, 9480.146786788946, 9591.520423978913, 9963.25275604318, 9965.850512242178, 9970.800583988135, 6540.50946179029, 6994.0, 7190.137183538009, 7226.421886248982, 7375.8156046099275, 8240.83518329642, 8282.958585207036, 8296.70961516344, 8351.20663536963, 8379.748607541784, 7253.673584688596, 7269.781906542812, 7545.245475452411, 7545.773626791205, 7683.961580192064, 7282.162551306667, 7441.62791860394, 7499.925000749922, 7554.697812087675, 7637.121731001006, 6683.699233534599, 6684.298148694317, 6691.966540167463, 6711.4966377520905, 6751.426128779109, 4933.9013219736125, 5092.0, 5096.541311282002, 5122.513361230677, 5238.71187084714, 4996.800127994839, 5110.284560161655, 5173.689578625144, 5244.580433565382, 5255.185446255837], "value": 4470.652155423232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.5406629288093, 315.99368012639763, 319.74260720120293, 336.46837995966376, 337.65221821523824, 5436.728163591824, 5487.451254874511, 5513.3108361454815, 5560.9165862512045, 5669.659820410773, 5619.466150715686, 5620.550355971523, 5620.606557540964, 5630.887382252363, 5648.406917273689, 4304.7632380219075, 4342.348647702838, 4344.370066340379, 4359.8692039238795, 4368.213721530124, 4106.993786522291, 4279.74321540707, 4344.913101737963, 4364.367166760818, 4395.132068870733, 4268.274393353122, 4350.36919646651, 4357.673174511909, 4409.29451287794, 4415.425994620711, 4395.934060989071, 4398.208322501932, 4406.272964960777, 4408.757518336491, 4432.955670443319, 3817.015152120882, 3873.341531939577, 3893.493845800056, 3904.726669133162, 3908.5309762828642, 5411.83764487066, 5443.482869127427, 5461.344638643349, 5467.617266791326, 5467.863303417406, 5043.3191519145175, 5072.949270507284, 5073.7209453480045, 5074.412049854601, 5096.9041656043755, 5661.1508273758855, 5876.61801982874, 5884.264466941632, 5907.822765317047, 5918.7928422505, 4261.3607958806115, 4271.9359209611885, 4296.5273819879785, 4297.570242975708, 4318.330658747867, 5993.280806303272, 6012.3085845127935, 6059.333473317932, 6059.939400605982, 6138.7237574309265, 4261.97869010653, 4381.342798580238, 4390.846320378771, 4396.736195828261, 4398.494173170063, 4433.401490798766, 4441.0, 4472.105578884236, 4476.395686582269, 4480.596746292849, 5065.290859279704, 5069.112905241568, 5074.391073071255, 5092.592592592584, 5092.8472145835685, 5677.205191273225, 5765.365809760923, 5849.298084229835, 5884.676342801187, 6016.939830601726, 1515.1590867068662, 1529.3806008566548, 1531.2420351925869, 1534.4015833824817, 1536.6004838741785, 952.766572189804, 958.7746879483316, 968.4673429613684, 969.2778879734643, 980.1668581705493, 5048.939722658283, 5083.237514372874, 5093.9490605094215, 5107.90575863894, 5135.486451354909, 5322.536302516762, 5323.908598737249, 5342.519173274346, 5342.759575819097, 5366.543843773323, 4770.570648641639, 4960.652754307236, 5022.475454437905, 5052.863105801165, 5100.336956195671, 2839.4037252177272, 2858.8713507892194, 2865.0831733845384, 2894.435585060893, 2900.303927057491, 5445.537129343971, 5472.318563903738, 5515.586331025189, 5557.5553955683445, 5563.5271001964475, 5402.972985135049, 5682.7782026864425, 6208.354785981718, 6228.626282423069, 6259.342769009279, 6286.339934306832, 6308.684565771693, 6349.2698339690605, 6366.204224471941, 6388.361163883667, 6048.637081774931, 6095.769242301587, 6121.204243448323, 6130.570860039755, 6152.169457123231, 6031.4064952069275, 6043.848903777441, 6052.969735151296, 6065.8474889770805, 6085.4523092921845, 6108.144859719554, 6355.841103972438, 6356.237251529846, 6371.808845734636, 6379.617222966637, 4225.809838557334, 4237.851675191477, 4240.045989652303, 4255.893602659959, 4290.699651024398, 5872.94127058741, 5904.291485021653, 6073.210482637229, 6179.671370655331, 6190.845228869314, 5854.970725146517, 5895.823125306248, 5901.734421950937, 5921.289445266596, 5960.5231581474245, 5923.763049477972, 5931.584789064724, 5950.851228719317, 5961.791337303173, 5991.191189189578, 5656.717164141859, 5831.475167234969, 5851.882962340815, 5855.882882342415, 5861.706914654335, 5977.9103313451205, 5989.263113696979, 6020.4280593343565, 6034.517238620988, 6061.181740464981, 5740.856478588069, 5872.324682661549, 5872.970635146968, 5874.471297583238, 5883.852903677443], "value": 4423.416853347311, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.5354749733917, 757.4886951307866, 775.4145620056856, 810.3233799777186, 830.7715378270976, 14467.0, 15542.0, 15551.0, 15605.0, 15609.0, 14147.292635368241, 14513.927430362859, 14525.636859078528, 14532.564023079298, 14552.0, 782.4444644302538, 786.0410299434709, 800.131856935223, 803.6945960534988, 818.5088946632033, 795.6300320351036, 795.8726603743402, 796.9721059762909, 799.9040115186186, 802.3821657323857, 844.4637655089001, 846.3483117999137, 847.6482259862149, 850.2390360627235, 850.7617866997219, 830.8255266394065, 841.7222316635496, 842.6208206307186, 843.1315744782884, 844.0588743550958, 615.827568280882, 615.9784407545759, 616.6762449713937, 618.0389494336305, 618.1438707390251, 13950.441982320695, 14083.788743168861, 14094.71810563783, 14109.223992680398, 14123.081999670092, 15007.624809379744, 15400.691986160215, 15429.768553471707, 15547.14490703011, 15645.295961681752, 11842.763144737142, 11924.46339914706, 12050.517979280818, 12153.116266978544, 12546.247225166519, 3917.5690674025836, 3918.8236529356245, 4025.376066709665, 4079.694022948261, 4085.734427262248, 78842.60578697127, 80072.79890801701, 80229.19770802333, 80241.0, 81341.0, 12007.594444693717, 12110.152289339661, 12171.208871423329, 12297.139200255897, 12410.937945310396, 22932.197373092196, 23050.884745576164, 23113.537729245658, 23132.537349253256, 23199.884000580227, 8586.65653373858, 8602.440841345293, 8686.218240358397, 8793.516356600448, 8810.823783524422, 4744.5729884309885, 4784.378030855966, 4825.131476334223, 4869.853904382803, 4912.312276281324, 3776.716746243988, 3934.6655534279907, 3948.6841052715713, 3949.7235193536753, 3961.1285517186175, 649.9535747446607, 652.8433176037717, 668.913041304637, 703.3601114233921, 744.4714252880407, 692.1244625548685, 727.4526784609675, 733.886247631618, 745.6271864067966, 794.9466956282948, 9698.515074246401, 9985.500724963722, 10220.233482488844, 10446.68659940203, 10466.499405255812, 708.6598432752205, 729.8503806719609, 736.3704033051664, 740.4372676765589, 765.479473957703, 4848.357958963909, 4995.0, 4998.025385049953, 5005.27423523587, 5016.072026675077, 118256.40871795759, 118639.0, 120190.39904800594, 120975.0, 123188.99271547321, 96522.0, 97594.0, 97775.0, 97868.0, 97989.0, 56639.71680141655, 74868.62565687137, 83193.58403207945, 86558.0, 87248.12751872528, 10007.035963253356, 10336.844947325946, 10362.792744145225, 10459.215558832966, 10819.945900270448, 36580.45129323009, 49596.0, 50064.0, 53963.11004856053, 54890.17664734952, 70340.64829676024, 73864.26135738574, 77415.2258477408, 77592.61203693945, 78620.60689696515, 12949.611511654666, 13073.738525229252, 13144.868551314747, 13445.663858403226, 13848.30758462093, 14789.482368117064, 15039.0, 15251.161186134868, 15279.465218717292, 15940.043597384194, 14535.709285814435, 14634.0, 14673.339699713326, 14778.77831832502, 15190.392384304503, 14159.575212743222, 14162.362693678602, 14451.49419770303, 14463.204523750874, 14851.925740371229, 14042.719145617235, 14163.575092746822, 14458.421663133357, 14617.415303387745, 14698.779518307449, 10441.843372349573, 11133.387663678575, 11755.764884702428, 11859.703507412383, 11968.16222864391, 10132.544035518567, 11009.229353945148, 11099.889001109885, 11147.609833655782, 11183.832242516532], "value": 7737.8251559033415, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 104.0, 109.0, 112.0, 111.0, 112.0, 110.0, 111.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 151.0, 178.0, 129.0, 158.0, 158.0, 127.0, 189.0, 129.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 172.0, 167.0, 162.0, 166.0, 160.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 152.0, 77.0, 77.0, 76.0, 76.0, 177.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 149.0, 86.0, 85.0, 84.0, 135.0, 85.0, 86.0, 152.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 146.0, 151.0, 149.0, 148.0, 149.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 56.0, 55.0, 56.0, 55.0, 55.0, 62.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 80.0, 85.0, 83.0, 79.0, 81.0, 80.0, 146.0, 80.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 124.0, 124.0, 121.0, 136.0, 126.0, 135.0, 132.0, 129.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 163.0, 170.0, 162.0, 169.0, 170.0, 165.0, 164.0, 164.0, 162.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 63.0, 63.0, 67.0, 62.0, 67.0, 63.0, 66.0, 63.0], "value": 64.6, "unit": "score"}]}]} 10:33:53 INFO - Return code: 0 10:33:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:33:53 ERROR - # TBPL SUCCESS # 10:33:53 INFO - Running post-action listener: _resource_record_post_action 10:33:53 INFO - ##### 10:33:53 INFO - ##### Finished run-tests step (success) 10:33:53 INFO - ##### 10:33:53 INFO - Running post-run listener: _resource_record_post_run 10:33:54 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 40960; Write bytes: 305352704; Read time: 56; Write time: 235624 10:33:54 INFO - TinderboxPrint: CPU usage
13.5% 10:33:54 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 56 10:33:54 INFO - TinderboxPrint: I/O write bytes / time
305,352,704 / 235,624 10:33:54 INFO - TinderboxPrint: CPU idle
8,227.4 (86.5%) 10:33:54 INFO - TinderboxPrint: CPU user
1,225.2 (12.9%) 10:33:54 INFO - TinderboxPrint: Swap in / out
0 / 0 10:33:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15548416; Read time: 0; Write time: 9780 10:33:54 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 40960; Write bytes: 289804288; Read time: 56; Write time: 225844 10:33:54 INFO - Running post-run listener: _upload_blobber_files 10:33:54 INFO - Blob upload gear active. 10:33:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:54 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 10:33:54 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'] 10:33:54 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 10:33:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:59 INFO - (blobuploader) - INFO - Done attempting. 10:33:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:33:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:59 INFO - (blobuploader) - INFO - Done attempting. 10:33:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:33:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:34:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:00 INFO - (blobuploader) - INFO - Done attempting. 10:34:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:00 INFO - Return code: 0 10:34:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:34:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa61bb94f72d90825458e209d079e345637a83f091823dda4bc07e36543a7b06efa7892e18ac51c8e05629c734945162217b44954a6c1cfe83424fc0602ba0b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8f0ed3392fbf901f0699826404979b55c94eb41a1113fd234b23b71adca0823c74e8249910fb5b379e1f427644fb07ef0b2a59ed53c8443737a6d2798f40b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0f235b89f6f86839a90d9aa9c39d3d21259d7d047ad1374cb8b7fd716684788f4dec16d460cf389a64af80e1de4645e71c7d32de476634bb8d78aeb2158025d"} 10:34:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:34:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:34:00 INFO - Contents: 10:34:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa61bb94f72d90825458e209d079e345637a83f091823dda4bc07e36543a7b06efa7892e18ac51c8e05629c734945162217b44954a6c1cfe83424fc0602ba0b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8f0ed3392fbf901f0699826404979b55c94eb41a1113fd234b23b71adca0823c74e8249910fb5b379e1f427644fb07ef0b2a59ed53c8443737a6d2798f40b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0f235b89f6f86839a90d9aa9c39d3d21259d7d047ad1374cb8b7fd716684788f4dec16d460cf389a64af80e1de4645e71c7d32de476634bb8d78aeb2158025d"} 10:34:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:00 INFO - Copying logs to upload dir... 10:34:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:34:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.690784 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 10:34:00.712994) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:34:00.716508) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915 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/fa61bb94f72d90825458e209d079e345637a83f091823dda4bc07e36543a7b06efa7892e18ac51c8e05629c734945162217b44954a6c1cfe83424fc0602ba0b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8f0ed3392fbf901f0699826404979b55c94eb41a1113fd234b23b71adca0823c74e8249910fb5b379e1f427644fb07ef0b2a59ed53c8443737a6d2798f40b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0f235b89f6f86839a90d9aa9c39d3d21259d7d047ad1374cb8b7fd716684788f4dec16d460cf389a64af80e1de4645e71c7d32de476634bb8d78aeb2158025d"} build_url:https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/f_ExEQJNQkedwnLLPQQHFg/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/fa61bb94f72d90825458e209d079e345637a83f091823dda4bc07e36543a7b06efa7892e18ac51c8e05629c734945162217b44954a6c1cfe83424fc0602ba0b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8f0ed3392fbf901f0699826404979b55c94eb41a1113fd234b23b71adca0823c74e8249910fb5b379e1f427644fb07ef0b2a59ed53c8443737a6d2798f40b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0f235b89f6f86839a90d9aa9c39d3d21259d7d047ad1374cb8b7fd716684788f4dec16d460cf389a64af80e1de4645e71c7d32de476634bb8d78aeb2158025d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:34:00.741901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:34:00.742244) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466788374.525395-1204801915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:34:00.825068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:34:00.825394) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:34:00.825703) ========= ========= Total master_lag: 0.47 =========