builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1469452678.11 results: success (0) buildid: 20160725020629 builduid: e9cffd69a2054ead90893fbe00f05894 revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.108985) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.109365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.109633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.146566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.146826) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 06:17:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2016-07-25 06:17:58 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121833 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.294293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.294605) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017980 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.349043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 06:17:58.349377) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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=e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 06:17:58,567 truncating revision to first 12 chars 2016-07-25 06:17:58,567 Setting DEBUG logging. 2016-07-25 06:17:58,567 attempt 1/10 2016-07-25 06:17:58,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/517663b29d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 06:17:59,570 unpacking tar archive at: mozilla-aurora-517663b29d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.325942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 06:17:59.690618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.691261) ========= script_repo_revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.692133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.693247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.704671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-25 06:17:59.704943) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:18:00 INFO - MultiFileLogger online at 20160725 06:18:00 in /builds/slave/test 06:18:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:18:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:18:00 INFO - {'append_to_log': False, 06:18:00 INFO - 'base_work_dir': '/builds/slave/test', 06:18:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:18:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:18:00 INFO - 'branch': 'Mozilla-Aurora', 06:18:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:18:00 INFO - 'config_files': ('talos/linux_config.py',), 06:18:00 INFO - 'default_actions': ('clobber', 06:18:00 INFO - 'read-buildbot-config', 06:18:00 INFO - 'download-and-extract', 06:18:00 INFO - 'populate-webroot', 06:18:00 INFO - 'create-virtualenv', 06:18:00 INFO - 'install', 06:18:00 INFO - 'run-tests'), 06:18:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:18:00 INFO - 'download_minidump_stackwalk': True, 06:18:00 INFO - 'download_symbols': 'ondemand', 06:18:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:18:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:18:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:18:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:18:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:18:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:18:00 INFO - 'installer_path': 'installer.exe', 06:18:00 INFO - 'log_level': 'info', 06:18:00 INFO - 'log_name': 'talos', 06:18:00 INFO - 'log_to_console': True, 06:18:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:18:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:18:00 INFO - 'opt_config_files': (), 06:18:00 INFO - 'pip_index': False, 06:18:00 INFO - 'sps_profile': False, 06:18:00 INFO - 'sps_profile_interval': 0, 06:18:00 INFO - 'suite': 'dromaeojs', 06:18:00 INFO - 'system_bits': '32', 06:18:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:18:00 INFO - 'title': 'talos-linux64-ix-067', 06:18:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:18:00 INFO - 'use_talos_json': True, 06:18:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:18:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:18:00 INFO - 'work_dir': 'build'} 06:18:00 INFO - ##### 06:18:00 INFO - ##### Running clobber step. 06:18:00 INFO - ##### 06:18:00 INFO - Running pre-action listener: _resource_record_pre_action 06:18:00 INFO - Running main action method: clobber 06:18:00 INFO - rmtree: /builds/slave/test/build 06:18:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:00 INFO - Running post-action listener: _resource_record_post_action 06:18:00 INFO - ##### 06:18:00 INFO - ##### Finished clobber step (success) 06:18:00 INFO - ##### 06:18:00 INFO - ##### 06:18:00 INFO - ##### Running read-buildbot-config step. 06:18:00 INFO - ##### 06:18:00 INFO - Running pre-action listener: _resource_record_pre_action 06:18:00 INFO - Running main action method: read_buildbot_config 06:18:00 INFO - Using buildbot properties: 06:18:00 INFO - { 06:18:00 INFO - "project": "", 06:18:00 INFO - "product": "firefox", 06:18:00 INFO - "script_repo_revision": "production", 06:18:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:18:00 INFO - "repository": "", 06:18:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:18:00 INFO - "buildid": "20160725020629", 06:18:00 INFO - "pgo_build": "True", 06:18:00 INFO - "basedir": "/builds/slave/test", 06:18:00 INFO - "buildnumber": 629, 06:18:00 INFO - "slavename": "talos-linux64-ix-067", 06:18:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:18:00 INFO - "platform": "ubuntu64_hw", 06:18:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:18:00 INFO - "branch": "mozilla-aurora", 06:18:00 INFO - "repo_path": "releases/mozilla-aurora", 06:18:00 INFO - "revision": "517663b29d7ffc2ce91f90dc7beaac4fa35e52e5", 06:18:00 INFO - "stage_platform": "linux64-pgo", 06:18:00 INFO - "builduid": "e9cffd69a2054ead90893fbe00f05894", 06:18:00 INFO - "slavebuilddir": "test" 06:18:00 INFO - } 06:18:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:18:00 INFO - Running post-action listener: _resource_record_post_action 06:18:00 INFO - ##### 06:18:00 INFO - ##### Finished read-buildbot-config step (success) 06:18:00 INFO - ##### 06:18:00 INFO - ##### 06:18:00 INFO - ##### Running download-and-extract step. 06:18:00 INFO - ##### 06:18:00 INFO - Running pre-action listener: _resource_record_pre_action 06:18:00 INFO - Running main action method: download_and_extract 06:18:00 INFO - mkdir: /builds/slave/test/build/tests 06:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:00 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:18:12 INFO - Downloaded 1361 bytes. 06:18:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:12 INFO - Using the following test package requirements: 06:18:12 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:18:12 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:18:12 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:18:12 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'jsshell-linux-x86_64.zip'], 06:18:12 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:18:12 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:18:12 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:18:12 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:18:12 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:18:12 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:18:12 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:18:12 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')]} 06:18:12 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:18:16 INFO - Downloaded 24494715 bytes. 06:18:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:18:18 INFO - Return code: 0 06:18:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:18: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')]} 06:18:18 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:18:22 INFO - Downloaded 24494715 bytes. 06:18:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:18:23 INFO - Return code: 0 06:18:23 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')]} 06:18:23 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:18:25 INFO - Downloaded 10833369 bytes. 06:18:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:18:26 INFO - Return code: 0 06:18: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')]} 06:18:26 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:18:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:18:28 INFO - Downloaded 63633994 bytes. 06:18:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:28 INFO - mkdir: /builds/slave/test/properties 06:18:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:28 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:28 INFO - Contents: 06:18:28 INFO - build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:29 INFO - Running post-action listener: _resource_record_post_action 06:18:29 INFO - Running post-action listener: set_extra_try_arguments 06:18:29 INFO - ##### 06:18:29 INFO - ##### Finished download-and-extract step (success) 06:18:29 INFO - ##### 06:18:29 INFO - ##### 06:18:29 INFO - ##### Running populate-webroot step. 06:18:29 INFO - ##### 06:18:29 INFO - Running pre-action listener: _resource_record_pre_action 06:18:29 INFO - Running main action method: populate_webroot 06:18:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:29 INFO - '--tppagecycles', 06:18:29 INFO - '7'], 06:18:29 INFO - 'tests': ['tsvgm']}}, 06:18:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:18:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:18:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['damp', 'tps']}, 06:18:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'tests': ['damp', 'tps']}, 06:18:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['dromaeo_dom']}, 06:18:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['a11yr', 06:18:29 INFO - 'ts_paint', 06:18:29 INFO - 'tpaint', 06:18:29 INFO - 'sessionrestore', 06:18:29 INFO - 'sessionrestore_no_auto_restore', 06:18:29 INFO - 'tabpaint']}, 06:18:29 INFO - 'other-e10s': {'tests': ['a11yr', 06:18:29 INFO - 'ts_paint', 06:18:29 INFO - 'tpaint', 06:18:29 INFO - 'sessionrestore', 06:18:29 INFO - 'sessionrestore_no_auto_restore', 06:18:29 INFO - 'tabpaint']}, 06:18:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:18:29 INFO - 'ts_paint', 06:18:29 INFO - 'tpaint', 06:18:29 INFO - 'sessionrestore', 06:18:29 INFO - 'sessionrestore_no_auto_restore', 06:18:29 INFO - 'tabpaint']}, 06:18:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:18:29 INFO - 'ts_paint', 06:18:29 INFO - 'tpaint', 06:18:29 INFO - 'sessionrestore', 06:18:29 INFO - 'sessionrestore_no_auto_restore', 06:18:29 INFO - 'tabpaint']}, 06:18:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['a11yr', 06:18:29 INFO - 'ts_paint', 06:18:29 INFO - 'tpaint', 06:18:29 INFO - 'sessionrestore', 06:18:29 INFO - 'sessionrestore_no_auto_restore', 06:18:29 INFO - 'tabpaint']}, 06:18:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['a11yr', 06:18:29 INFO - 'ts_paint', 06:18:29 INFO - 'tpaint', 06:18:29 INFO - 'sessionrestore', 06:18:29 INFO - 'sessionrestore_no_auto_restore', 06:18:29 INFO - 'tabpaint']}, 06:18:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['tsvgx', 06:18:29 INFO - 'tsvgr_opacity', 06:18:29 INFO - 'tart', 06:18:29 INFO - 'tscrollx', 06:18:29 INFO - 'cart']}, 06:18:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:18:29 INFO - 'tsvgr_opacity', 06:18:29 INFO - 'tart', 06:18:29 INFO - 'tscrollx', 06:18:29 INFO - 'cart']}, 06:18:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'talos_options': ['--disable-e10s'], 06:18:29 INFO - 'tests': ['tp5o']}, 06:18:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'tests': ['tp5o']}, 06:18:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'talos_options': ['--disable-e10s', 06:18:29 INFO - '--xperf_path', 06:18:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:29 INFO - 'tests': ['tp5n']}, 06:18:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:29 INFO - 'talos_options': ['--xperf_path', 06:18:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:29 INFO - 'tests': ['tp5n']}}, 06:18:29 INFO - 'talos.zip': {'path': '', 06:18:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:29 INFO - Running post-action listener: _resource_record_post_action 06:18:29 INFO - ##### 06:18:29 INFO - ##### Finished populate-webroot step (success) 06:18:29 INFO - ##### 06:18:29 INFO - ##### 06:18:29 INFO - ##### Running create-virtualenv step. 06:18:29 INFO - ##### 06:18:29 INFO - Running pre-action listener: _resource_record_pre_action 06:18:29 INFO - Running main action method: create_virtualenv 06:18:29 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:29 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 06:18:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:29 INFO - Using real prefix '/usr' 06:18:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:29 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:31 INFO - Installing pip.................done. 06:18:31 INFO - Return code: 0 06:18:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:31 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 06:18:31 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 06:18:31 INFO - Using env: {'DISPLAY': ':0', 06:18:31 INFO - 'HOME': '/home/cltbld', 06:18:31 INFO - 'LANG': 'en_US.UTF-8', 06:18:31 INFO - 'LANGUAGE': 'en_US:en', 06:18:31 INFO - 'LOGNAME': 'cltbld', 06:18:31 INFO - 'MAIL': '/var/mail/cltbld', 06:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:31 INFO - 'MOZ_NO_REMOTE': '1', 06:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:31 INFO - 'NO_EM_RESTART': '1', 06:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:31 INFO - 'PWD': '/builds/slave/test', 06:18:31 INFO - 'SHELL': '/bin/bash', 06:18:31 INFO - 'SHLVL': '1', 06:18:31 INFO - 'TERM': 'linux', 06:18:31 INFO - 'TMOUT': '86400', 06:18:31 INFO - 'USER': 'cltbld', 06:18:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:31 INFO - '_': '/tools/buildbot/bin/python'} 06:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:31 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 06:18:31 INFO - Cleaning up... 06:18:31 INFO - Return code: 0 06:18:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:31 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 06:18:31 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 06:18:31 INFO - Using env: {'DISPLAY': ':0', 06:18:31 INFO - 'HOME': '/home/cltbld', 06:18:31 INFO - 'LANG': 'en_US.UTF-8', 06:18:31 INFO - 'LANGUAGE': 'en_US:en', 06:18:31 INFO - 'LOGNAME': 'cltbld', 06:18:31 INFO - 'MAIL': '/var/mail/cltbld', 06:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:31 INFO - 'MOZ_NO_REMOTE': '1', 06:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:31 INFO - 'NO_EM_RESTART': '1', 06:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:31 INFO - 'PWD': '/builds/slave/test', 06:18:31 INFO - 'SHELL': '/bin/bash', 06:18:31 INFO - 'SHLVL': '1', 06:18:31 INFO - 'TERM': 'linux', 06:18:31 INFO - 'TMOUT': '86400', 06:18:31 INFO - 'USER': 'cltbld', 06:18:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:31 INFO - '_': '/tools/buildbot/bin/python'} 06:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:32 INFO - Downloading/unpacking psutil>=3.1.1 06:18:32 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 06:18:32 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 06:18:32 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 06:18:32 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 06:18:32 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 06:18:32 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 06:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:34 INFO - Installing collected packages: psutil 06:18:34 INFO - Running setup.py install for psutil 06:18:34 INFO - building 'psutil._psutil_linux' extension 06:18:34 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 06:18:34 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 06:18:34 INFO - building 'psutil._psutil_posix' extension 06:18:34 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 06:18:34 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 06:18:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:34 INFO - Successfully installed psutil 06:18:34 INFO - Cleaning up... 06:18:34 INFO - Return code: 0 06:18:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:34 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 06:18:34 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 06:18:34 INFO - Using env: {'DISPLAY': ':0', 06:18:34 INFO - 'HOME': '/home/cltbld', 06:18:34 INFO - 'LANG': 'en_US.UTF-8', 06:18:34 INFO - 'LANGUAGE': 'en_US:en', 06:18:34 INFO - 'LOGNAME': 'cltbld', 06:18:34 INFO - 'MAIL': '/var/mail/cltbld', 06:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:34 INFO - 'MOZ_NO_REMOTE': '1', 06:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:34 INFO - 'NO_EM_RESTART': '1', 06:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:34 INFO - 'PWD': '/builds/slave/test', 06:18:34 INFO - 'SHELL': '/bin/bash', 06:18:34 INFO - 'SHLVL': '1', 06:18:34 INFO - 'TERM': 'linux', 06:18:34 INFO - 'TMOUT': '86400', 06:18:34 INFO - 'USER': 'cltbld', 06:18:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:34 INFO - '_': '/tools/buildbot/bin/python'} 06:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:18:34 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 06:18:34 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 06:18:34 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 06:18:34 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 06:18:34 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 06:18:34 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 06:18:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:18:36 INFO - Installing collected packages: mozsystemmonitor 06:18:36 INFO - Running setup.py install for mozsystemmonitor 06:18:37 INFO - Successfully installed mozsystemmonitor 06:18:37 INFO - Cleaning up... 06:18:37 INFO - Return code: 0 06:18:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:37 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:37 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 06:18:37 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 06:18:37 INFO - Using env: {'DISPLAY': ':0', 06:18:37 INFO - 'HOME': '/home/cltbld', 06:18:37 INFO - 'LANG': 'en_US.UTF-8', 06:18:37 INFO - 'LANGUAGE': 'en_US:en', 06:18:37 INFO - 'LOGNAME': 'cltbld', 06:18:37 INFO - 'MAIL': '/var/mail/cltbld', 06:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:37 INFO - 'MOZ_NO_REMOTE': '1', 06:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:37 INFO - 'NO_EM_RESTART': '1', 06:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:37 INFO - 'PWD': '/builds/slave/test', 06:18:37 INFO - 'SHELL': '/bin/bash', 06:18:37 INFO - 'SHLVL': '1', 06:18:37 INFO - 'TERM': 'linux', 06:18:37 INFO - 'TMOUT': '86400', 06:18:37 INFO - 'USER': 'cltbld', 06:18:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:37 INFO - '_': '/tools/buildbot/bin/python'} 06:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:37 INFO - Downloading/unpacking jsonschema==2.5.1 06:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:39 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:39 INFO - warning: no files found matching '*.txt' 06:18:39 INFO - no previously-included directories found matching 'build' 06:18:39 INFO - no previously-included directories found matching 'dist' 06:18:39 INFO - no previously-included directories found matching '.git*' 06:18:39 INFO - Installing collected packages: jsonschema, functools32 06:18:39 INFO - Running setup.py install for functools32 06:18:39 INFO - warning: no files found matching '*.txt' 06:18:39 INFO - no previously-included directories found matching 'build' 06:18:39 INFO - no previously-included directories found matching 'dist' 06:18:39 INFO - no previously-included directories found matching '.git*' 06:18:39 INFO - Successfully installed jsonschema functools32 06:18:39 INFO - Cleaning up... 06:18:39 INFO - Return code: 0 06:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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', '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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:18: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 blobuploader==1.2.4 06:18:39 INFO - Using env: {'DISPLAY': ':0', 06:18:39 INFO - 'HOME': '/home/cltbld', 06:18:39 INFO - 'LANG': 'en_US.UTF-8', 06:18:39 INFO - 'LANGUAGE': 'en_US:en', 06:18:39 INFO - 'LOGNAME': 'cltbld', 06:18:39 INFO - 'MAIL': '/var/mail/cltbld', 06:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:39 INFO - 'MOZ_NO_REMOTE': '1', 06:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:39 INFO - 'NO_EM_RESTART': '1', 06:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:39 INFO - 'PWD': '/builds/slave/test', 06:18:39 INFO - 'SHELL': '/bin/bash', 06:18:39 INFO - 'SHLVL': '1', 06:18:39 INFO - 'TERM': 'linux', 06:18:39 INFO - 'TMOUT': '86400', 06:18:39 INFO - 'USER': 'cltbld', 06:18:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:39 INFO - '_': '/tools/buildbot/bin/python'} 06:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:41 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:41 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 06:18:41 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 06:18:41 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 06:18:41 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 06:18:41 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 06:18:41 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 06:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:42 INFO - Downloading docopt-0.6.1.tar.gz 06:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:42 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:42 INFO - Running setup.py install for blobuploader 06:18:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:42 INFO - Running setup.py install for requests 06:18:43 INFO - Running setup.py install for docopt 06:18:43 INFO - Successfully installed blobuploader requests docopt 06:18:43 INFO - Cleaning up... 06:18:43 INFO - Return code: 0 06:18:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:43 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')]} 06:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:43 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')]} 06:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:43 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:43 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 06:18:43 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 06:18:43 INFO - Using env: {'DISPLAY': ':0', 06:18:43 INFO - 'HOME': '/home/cltbld', 06:18:43 INFO - 'LANG': 'en_US.UTF-8', 06:18:43 INFO - 'LANGUAGE': 'en_US:en', 06:18:43 INFO - 'LOGNAME': 'cltbld', 06:18:43 INFO - 'MAIL': '/var/mail/cltbld', 06:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:43 INFO - 'MOZ_NO_REMOTE': '1', 06:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:43 INFO - 'NO_EM_RESTART': '1', 06:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:43 INFO - 'PWD': '/builds/slave/test', 06:18:43 INFO - 'SHELL': '/bin/bash', 06:18:43 INFO - 'SHLVL': '1', 06:18:43 INFO - 'TERM': 'linux', 06:18:43 INFO - 'TMOUT': '86400', 06:18:43 INFO - 'USER': 'cltbld', 06:18:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:43 INFO - '_': '/tools/buildbot/bin/python'} 06:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:43 INFO - Running setup.py (path:/tmp/pip-04kLGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:43 INFO - Running setup.py (path:/tmp/pip-CyDd83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:43 INFO - Running setup.py (path:/tmp/pip-WqO9Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:43 INFO - Running setup.py (path:/tmp/pip-jqBqJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:43 INFO - Running setup.py (path:/tmp/pip-cXjyZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:43 INFO - Running setup.py (path:/tmp/pip-gg2I84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:43 INFO - Running setup.py (path:/tmp/pip-y3obh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:43 INFO - Running setup.py (path:/tmp/pip-rTKKvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:43 INFO - Running setup.py (path:/tmp/pip-8G9T9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:44 INFO - Running setup.py (path:/tmp/pip-HQLvvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:44 INFO - Running setup.py (path:/tmp/pip-kuuvwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:44 INFO - Running setup.py (path:/tmp/pip-TP6lWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:44 INFO - Running setup.py (path:/tmp/pip-buXrb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:44 INFO - Running setup.py (path:/tmp/pip-QTYpf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:44 INFO - Running setup.py (path:/tmp/pip-ygvnfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:44 INFO - Running setup.py (path:/tmp/pip-l7LPjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:44 INFO - Running setup.py (path:/tmp/pip-AYLHMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:44 INFO - Running setup.py install for manifestparser 06:18:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:44 INFO - Running setup.py install for mozcrash 06:18:44 INFO - Running setup.py install for mozdebug 06:18:44 INFO - Running setup.py install for mozdevice 06:18:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozfile 06:18:45 INFO - Running setup.py install for mozhttpd 06:18:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozinfo 06:18:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozInstall 06:18:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozleak 06:18:45 INFO - Running setup.py install for mozlog 06:18:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for moznetwork 06:18:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozprocess 06:18:45 INFO - Running setup.py install for mozprofile 06:18:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Running setup.py install for mozrunner 06:18:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:46 INFO - Running setup.py install for mozscreenshot 06:18:46 INFO - Running setup.py install for moztest 06:18:46 INFO - Running setup.py install for mozversion 06:18:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:46 INFO - Cleaning up... 06:18:46 INFO - Return code: 0 06:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:46 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:46 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 06:18:46 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 06:18:46 INFO - Using env: {'DISPLAY': ':0', 06:18:46 INFO - 'HOME': '/home/cltbld', 06:18:46 INFO - 'LANG': 'en_US.UTF-8', 06:18:46 INFO - 'LANGUAGE': 'en_US:en', 06:18:46 INFO - 'LOGNAME': 'cltbld', 06:18:46 INFO - 'MAIL': '/var/mail/cltbld', 06:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:46 INFO - 'MOZ_NO_REMOTE': '1', 06:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:46 INFO - 'NO_EM_RESTART': '1', 06:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:46 INFO - 'PWD': '/builds/slave/test', 06:18:46 INFO - 'SHELL': '/bin/bash', 06:18:46 INFO - 'SHLVL': '1', 06:18:46 INFO - 'TERM': 'linux', 06:18:46 INFO - 'TMOUT': '86400', 06:18:46 INFO - 'USER': 'cltbld', 06:18:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:46 INFO - '_': '/tools/buildbot/bin/python'} 06:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:46 INFO - Running setup.py (path:/tmp/pip-zUX4L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:46 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)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:46 INFO - Running setup.py (path:/tmp/pip-dCWSJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:46 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)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:46 INFO - Running setup.py (path:/tmp/pip-zTRmWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:46 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)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:46 INFO - Running setup.py (path:/tmp/pip-F3SduT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:46 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)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:46 INFO - Running setup.py (path:/tmp/pip-QVzMgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:46 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)) 06:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:46 INFO - Running setup.py (path:/tmp/pip-K2ukQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:47 INFO - Running setup.py (path:/tmp/pip-jciIDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:47 INFO - Running setup.py (path:/tmp/pip-d1D7AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:47 INFO - Running setup.py (path:/tmp/pip-JFxHS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:47 INFO - Running setup.py (path:/tmp/pip-o8jQoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:47 INFO - Running setup.py (path:/tmp/pip-8EnMKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:47 INFO - Running setup.py (path:/tmp/pip-KV_sZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:47 INFO - Running setup.py (path:/tmp/pip-yVBKKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:47 INFO - Running setup.py (path:/tmp/pip-P4TBe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:47 INFO - Running setup.py (path:/tmp/pip-gsq47_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:47 INFO - Running setup.py (path:/tmp/pip-J122aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:47 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)) 06:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:47 INFO - Running setup.py (path:/tmp/pip-DF9E8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:47 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)) 06:18:47 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)) 06:18:47 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)) 06:18:47 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)) 06:18:47 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)) 06:18:47 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)) 06:18:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:49 INFO - Downloading blessings-1.6.tar.gz 06:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:49 INFO - Installing collected packages: blessings 06:18:49 INFO - Running setup.py install for blessings 06:18:49 INFO - Successfully installed blessings 06:18:49 INFO - Cleaning up... 06:18:50 INFO - Return code: 0 06:18:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:50 INFO - Reading from file tmpfile_stdout 06:18:50 INFO - Current package versions: 06:18:50 INFO - argparse == 1.2.1 06:18:50 INFO - blessings == 1.6 06:18:50 INFO - blobuploader == 1.2.4 06:18:50 INFO - docopt == 0.6.1 06:18:50 INFO - functools32 == 3.2.3-2 06:18:50 INFO - jsonschema == 2.5.1 06:18:50 INFO - manifestparser == 1.1 06:18:50 INFO - mozInstall == 1.12 06:18:50 INFO - mozcrash == 0.17 06:18:50 INFO - mozdebug == 0.1 06:18:50 INFO - mozdevice == 0.48 06:18:50 INFO - mozfile == 1.2 06:18:50 INFO - mozhttpd == 0.7 06:18:50 INFO - mozinfo == 0.9 06:18:50 INFO - mozleak == 0.1 06:18:50 INFO - mozlog == 3.2 06:18:50 INFO - moznetwork == 0.27 06:18:50 INFO - mozprocess == 0.23 06:18:50 INFO - mozprofile == 0.28 06:18:50 INFO - mozrunner == 6.12 06:18:50 INFO - mozscreenshot == 0.1 06:18:50 INFO - mozsystemmonitor == 0.3 06:18:50 INFO - moztest == 0.7 06:18:50 INFO - mozversion == 1.4 06:18:50 INFO - psutil == 3.1.1 06:18:50 INFO - requests == 1.2.3 06:18:50 INFO - wsgiref == 0.1.2 06:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:50 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:50 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 06:18:50 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 06:18:50 INFO - Using env: {'DISPLAY': ':0', 06:18:50 INFO - 'HOME': '/home/cltbld', 06:18:50 INFO - 'LANG': 'en_US.UTF-8', 06:18:50 INFO - 'LANGUAGE': 'en_US:en', 06:18:50 INFO - 'LOGNAME': 'cltbld', 06:18:50 INFO - 'MAIL': '/var/mail/cltbld', 06:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:50 INFO - 'MOZ_NO_REMOTE': '1', 06:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:50 INFO - 'NO_EM_RESTART': '1', 06:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:50 INFO - 'PWD': '/builds/slave/test', 06:18:50 INFO - 'SHELL': '/bin/bash', 06:18:50 INFO - 'SHLVL': '1', 06:18:50 INFO - 'TERM': 'linux', 06:18:50 INFO - 'TMOUT': '86400', 06:18:50 INFO - 'USER': 'cltbld', 06:18:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:50 INFO - '_': '/tools/buildbot/bin/python'} 06:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 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)) 06:18:50 INFO - Cleaning up... 06:18:50 INFO - Return code: 0 06:18:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:50 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:50 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 06:18:50 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 06:18:50 INFO - Using env: {'DISPLAY': ':0', 06:18:50 INFO - 'HOME': '/home/cltbld', 06:18:50 INFO - 'LANG': 'en_US.UTF-8', 06:18:50 INFO - 'LANGUAGE': 'en_US:en', 06:18:50 INFO - 'LOGNAME': 'cltbld', 06:18:50 INFO - 'MAIL': '/var/mail/cltbld', 06:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:50 INFO - 'MOZ_NO_REMOTE': '1', 06:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:50 INFO - 'NO_EM_RESTART': '1', 06:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:50 INFO - 'PWD': '/builds/slave/test', 06:18:50 INFO - 'SHELL': '/bin/bash', 06:18:50 INFO - 'SHLVL': '1', 06:18:50 INFO - 'TERM': 'linux', 06:18:50 INFO - 'TMOUT': '86400', 06:18:50 INFO - 'USER': 'cltbld', 06:18:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:50 INFO - '_': '/tools/buildbot/bin/python'} 06:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:18:50 INFO - Cleaning up... 06:18:50 INFO - Return code: 0 06:18:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:50 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 0x7f4b486abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', '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 06:18:50 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 06:18:50 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 06:18:50 INFO - Using env: {'DISPLAY': ':0', 06:18:50 INFO - 'HOME': '/home/cltbld', 06:18:50 INFO - 'LANG': 'en_US.UTF-8', 06:18:50 INFO - 'LANGUAGE': 'en_US:en', 06:18:50 INFO - 'LOGNAME': 'cltbld', 06:18:50 INFO - 'MAIL': '/var/mail/cltbld', 06:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:50 INFO - 'MOZ_NO_REMOTE': '1', 06:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:50 INFO - 'NO_EM_RESTART': '1', 06:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:50 INFO - 'PWD': '/builds/slave/test', 06:18:50 INFO - 'SHELL': '/bin/bash', 06:18:50 INFO - 'SHLVL': '1', 06:18:50 INFO - 'TERM': 'linux', 06:18:50 INFO - 'TMOUT': '86400', 06:18:50 INFO - 'USER': 'cltbld', 06:18:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:50 INFO - '_': '/tools/buildbot/bin/python'} 06:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:50 INFO - Downloading/unpacking flake8 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:18:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:18:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:53 INFO - no previously-included directories found matching 'docs/_build' 06:18:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:18:53 INFO - Running setup.py install for pep8 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:53 INFO - no previously-included directories found matching 'docs/_build' 06:18:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:18:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:18:53 INFO - Cleaning up... 06:18:54 INFO - Return code: 0 06:18:54 INFO - Running post-action listener: _resource_record_post_action 06:18:54 INFO - Running post-action listener: _start_resource_monitoring 06:18:54 INFO - Starting resource monitoring. 06:18:54 INFO - ##### 06:18:54 INFO - ##### Finished create-virtualenv step (success) 06:18:54 INFO - ##### 06:18:54 INFO - ##### 06:18:54 INFO - ##### Running install step. 06:18:54 INFO - ##### 06:18:54 INFO - Running pre-action listener: _resource_record_pre_action 06:18:54 INFO - Running main action method: install 06:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:54 INFO - Reading from file tmpfile_stdout 06:18:54 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:54 INFO - Reading from file tmpfile_stdout 06:18:54 INFO - Output received: 06:18:54 INFO - Usage: mozinstall [options] installer 06:18:54 INFO - Options: 06:18:54 INFO - -h, --help show this help message and exit 06:18:54 INFO - -d DEST, --destination=DEST 06:18:54 INFO - Directory to install application into. [default: 06:18:54 INFO - "/builds/slave/test"] 06:18:54 INFO - --app=APP Application being installed. [default: firefox] 06:18:54 INFO - mkdir: /builds/slave/test/build/application 06:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:19:10 INFO - Reading from file tmpfile_stdout 06:19:10 INFO - Output received: 06:19:10 INFO - /builds/slave/test/build/application/firefox/firefox 06:19:10 INFO - Running post-action listener: _resource_record_post_action 06:19:10 INFO - ##### 06:19:10 INFO - ##### Finished install step (success) 06:19:10 INFO - ##### 06:19:10 INFO - ##### 06:19:10 INFO - ##### Running run-tests step. 06:19:10 INFO - ##### 06:19:10 INFO - Running pre-action listener: _resource_record_pre_action 06:19:10 INFO - Running main action method: run_tests 06:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:10 INFO - Python 2.7.3 06:19:10 INFO - Return code: 0 06:19:10 INFO - grabbing minidump binary from tooltool 06:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:10 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 0x2cf51c0>, '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 0x2cf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:10 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 06:19:10 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 06:19:10 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 06:19:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:10 INFO - Return code: 0 06:19:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:19:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:19:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:19:11 INFO - Return code: 0 06:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:19:11 INFO - Using env: {'DISPLAY': ':0', 06:19:11 INFO - 'HOME': '/home/cltbld', 06:19:11 INFO - 'LANG': 'en_US.UTF-8', 06:19:11 INFO - 'LANGUAGE': 'en_US:en', 06:19:11 INFO - 'LOGNAME': 'cltbld', 06:19:11 INFO - 'MAIL': '/var/mail/cltbld', 06:19:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:11 INFO - 'MOZ_NO_REMOTE': '1', 06:19:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:11 INFO - 'NO_EM_RESTART': '1', 06:19:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:11 INFO - 'PWD': '/builds/slave/test', 06:19:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:11 INFO - 'SHELL': '/bin/bash', 06:19:11 INFO - 'SHLVL': '1', 06:19:11 INFO - 'TERM': 'linux', 06:19:11 INFO - 'TMOUT': '86400', 06:19:11 INFO - 'USER': 'cltbld', 06:19:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022', 06:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:11 INFO - '_': '/tools/buildbot/bin/python'} 06:19:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:19:11 INFO - mozversion application_buildid: 20160725020629 06:19:11 INFO - mozversion application_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 06:19:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:19:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:11 INFO - mozversion application_name: Firefox 06:19:11 INFO - mozversion application_remotingname: firefox-dev 06:19:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:11 INFO - mozversion application_vendor: Mozilla 06:19:11 INFO - mozversion application_version: 49.0a2 06:19:11 INFO - mozversion platform_buildid: 20160725020629 06:19:11 INFO - mozversion platform_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 06:19:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:11 INFO - mozversion platform_version: 49.0a2 06:19:11 INFO - using testdate: 1469452751 06:19:11 INFO - actual date: 1469452751 06:19:11 INFO - starting webserver on 'localhost:57124' 06:19:11 INFO - SUITE-START | Running 2 tests 06:19:11 INFO - TEST-START | dromaeo_css 06:19:11 INFO - operating with platform_type : linux_ 06:19:11 INFO - Initialising browser for dromaeo_css test... 06:19:11 INFO - TEST-INFO | started process 24043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPnQh39/profile http://localhost:57124/getInfo.html) 06:19:15 INFO - PROCESS | 24043 | __metrics Screen width/height:1600/1200 06:19:15 INFO - PROCESS | 24043 | colorDepth:24 06:19:15 INFO - PROCESS | 24043 | Browser inner width/height: 1024/697 06:19:15 INFO - PROCESS | 24043 | __metrics 06:19:16 INFO - PROCESS | 24043 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:19:16 ERROR - PROCESS | 24043 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:19:17 INFO - TEST-INFO | 24043: exit 0 06:19:17 INFO - Browser initialized. 06:19:17 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:17 INFO - TEST-INFO | started process 24134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPnQh39/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:29 INFO - PROCESS | 24134 | RSS: Main: 145248256 06:19:29 INFO - PROCESS | 24134 | 06:20:20 INFO - PROCESS | 24134 | 1469452820182 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] 06:22:28 INFO - PROCESS | 24134 | Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57124/tests/dromaeo/cssquery-ext.html) 06:22:29 INFO - PROCESS | 24134 | RSS: Main: 253992960 06:22:29 INFO - PROCESS | 24134 | 06:25:31 INFO - PROCESS | 24134 | Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-ext.html (next: http://localhost:57124/tests/dromaeo/cssquery-jquery.html) 06:25:32 INFO - PROCESS | 24134 | RSS: Main: 230899712 06:25:32 INFO - PROCESS | 24134 | 06:28:33 INFO - PROCESS | 24134 | Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57124/tests/dromaeo/cssquery-mootools.html) 06:28:34 INFO - PROCESS | 24134 | RSS: Main: 225153024 06:28:34 INFO - PROCESS | 24134 | 06:31:36 INFO - PROCESS | 24134 | Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57124/tests/dromaeo/cssquery-prototype.html) 06:31:37 INFO - PROCESS | 24134 | RSS: Main: 219574272 06:31:37 INFO - PROCESS | 24134 | 06:34:39 INFO - PROCESS | 24134 | Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57124/tests/dromaeo/cssquery-yui.html) 06:34:40 INFO - PROCESS | 24134 | RSS: Main: 216428544 06:34:40 INFO - PROCESS | 24134 | 06:37:42 INFO - PROCESS | 24134 | Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-yui.html (next: http://localhost:57124/tests/dromaeo/cssquery-dojo.html) 06:37:43 INFO - PROCESS | 24134 | RSS: Main: 259514368 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | __start_tp_report 06:37:43 INFO - PROCESS | 24134 | _x_x_mozilla_page_load 06:37:43 INFO - PROCESS | 24134 | _x_x_mozilla_page_load_details 06:37:43 INFO - PROCESS | 24134 | |i|pagename|runs| 06:37:43 INFO - PROCESS | 24134 | |0;dojo.html;3319.4688849784025;3328.5173649820777;3352.379809735199;3354.64776198499;3394.6944774970248;5461.754221060052;5518.365387980383;5560.277163968683;5566.276384070075;5587.133994230896;5545.916811247825;5644.8306550803545;5647.661140331573;5654.067078931971;5679.687617181054;4998.250262460624;5113.488651134894;5140.742962851842;5172.793088276483;5217.060929032773;5021.1213037718435;5168.948310516903;5206.973965130169;5207.297014902996;5211.869703257411;5056.418511871145;5092.388913330406;5123.333966584339;5125.410577783566;5170.586353091744;5119.2321151827155;5132.666376685522;5144.819931302424;5146.974265128688;5147.073526765181;4959.925601115986;5024.874378140539;5037.093323201822;5057;5057.216131499624;5328.46715328468;5340.786368545254;5362.973185134088;5384.353877534721;5397.676139431607;5896.646201227897;5901.380355062743;5907.320658124328;5913.113033045078;5913.556483263773;5905.438983296623;5921.674307913063;5949.524038076944;5974.312954010301;5996.4603185713495;5628.549716022709;5643.153526970947;5669.206311116447;5672.290963629546;5683.630564013409;5800.796972106041;6130.049842274455;6145.231846019247;6145.631262124287;6149.292831324455;5797.710114494258;5891.05743081105;5932.940670593325;5953.166556682068;5959.0763431668165;6011.458968692838;6017.969910150421;6023.849403764853;6051.062085376773;6054.3945605439985;5714.885702285931;5777.2200752897825;5985.221921150222;5994.22075130239;6006.339302676702;5728.455796699307;5841.591088623755;5850.180974663551;5853.473187413153;5892.234009578728;4516.051629157848;4518.751468669255;4529.275315949432;4529.954700452953;4554.817807287672;3989.4215338775716;4022.8793136205377;4033.9193216135513;4036.555978842325;4077.9796101019897;5679.261695979496;5684.175794509773;5698.287714035746;5705.5720820938595;5734.139879018181;5972.880542389128;5982.641041537521;5985.34161242263;5997.160397544348;6020.638761674313;5456.590755693339;5589.944100559023;5634.183043458757;5640.153976903415;5674.687892165888;5079.161938280216;5081.542661160439;5084.720340381315;5090.2364645303505;5110.131277682803;6220.03589443637;6231.657258850716;6236.064590311489;6241.78153764616;6244.313125556185;5699.51554117888;5930.11048342752;5969.253843269591;5976.073708575178;5981.7607295707685;6226.719797609209;6238.189035425366;6266.530010249158;6279.780207692709;6286.717097730521;5896.469317761422;5910.911336330045;5919.940800592111;5925.555583331181;5949.8215053548465;5750.597458178055;5881.17663527098;5939.07944268639;5952.940470595238;6003.669798161143;5848.912266315923;5849.766009359748;5850.53195744348;5865.501432378295;5868.3251426084835;5593.524550413261;5799.333076696065;5842.7662893485485;5857.150713146485;5862.149988251765;5622.971885140548;5677.148427735872;5686.061799803151;5732.455416735404;5737.282839645044;5807.245058142415;5839.562032847469;5881;5882.647041177543;5884.7940322088525;5580.665160090408;5627.577931655224;5744.684042377709;5750.166225897305;5762.827115186551 06:37:43 INFO - PROCESS | 24134 | |1;ext.html;605.2948315212777;637.1016866218632;642.8392901774556;664.6942406493013;677.1332694151484;33432.49851252233;45740.313895291554;46458.535414645885;46500.06999860001;46572;48519.27221091687;48902;48947.26579101307;49016.264756028686;49075.26387104196;8319.334453243726;9022.188003079722;9159.313051521163;9167;10614.310069845475;10749.032587067162;10858;10858.457077146151;10864.130869530458;10877.292975956578;10616.946915265413;10653.467326633676;10655.573777048947;10664.30682005671;10680.786384272309;8224.259816616503;8330.125336839666;10724;10887.346759194434;10968.506417211245;10386.688399348031;10520.421376824272;10522.842157367646;10538.789224215549;10540.789184216273;45366.77316613429;45836.54163458356;45859.77070114661;45920;45998.77000614975;3540.2565461253166;3584.5877724061806;3712.5916149223563;3724.1992971511254;3812.2566099610585;34948.301033979435;35246.64753352459;35604.46593301102;36306.63693363059;36371.81814090939;4555.589996900262;4570.291604801261;4623.1678297906365;4727.149113159629;4795.520447955177;404194;405879.99999999703;406281;406536;407094;38693.806530967166;71752.64123679453;72249.27750722531;72267;72354.63822680853;39585.80207098946;41642.37536436956;41681.583184168376;41691.37462938058;41715.7914210427;17555.824441755674;17828.3760068397;17832.732509012374;17836.732449013274;17841.7323740144;13389.866101339057;14404.351804168837;14515.92742036283;14542.345594448276;15030.248487575578;9124.406913550598;9131.954340228389;9173.128552787475;9220.7694807629;9249.630014799468;3488.598811136701;3552.4138517144897;3575.0526110580718;3576.5529308836394;3603.6216197298904;1010.4038617215878;1073.1361254190451;1090.939998300101;1151.1826603111883;1156.4160099150045;33878.32243355119;33969.49045764316;34290.82854585711;34651.30697386038;35073.29853402918;1196.730735584504;1214.9271043737403;1250.5373011985623;1253.9874601254053;1268.0172866028902;17620.471385858444;17917.641647167246;18153.818461815477;18200.1809918554;18273.451796446127;637900;643492;650360;652746;656907;64353.356466434736;64996.35003649998;65026;65090.67454662791;65270.347296527376;1340.611222745393;1420.6897927828136;1462.817147856518;1475.9704805904037;1482.3774014913977;34338.82830585831;35159;35661.82169089138;35849.46225806667;36031.27937441184;53144.734276328374;53748;53753.46246537485;53790.73104634452;53947.190792138936;489150;489899;490094;491263;491691;27598.72401276042;30089.699103009567;30874.69125308718;31018.68981310158;32335.838320808245;51352.48647513626;52622.73688631685;53081;53499;53652.73173634107;43377.132457350046;43384;43600.34599481074;44371.55628443803;44420.55579444164;43397.78301108474;43776.56223437725;44453.555464444944;44600.33099503575;44909.775451122536;44332;45165.09669806651;45436;45567;45616.31575526304;37592.2481550362;37968.620313796506;38636.22727545377;38969;39314.213715726095;29348.21191986758;29475.557866632447;29515.114546563636;29586.260343491584;29601.555976659936 06:37:43 INFO - PROCESS | 24134 | |2;jquery.html;419.6433031922868;419.8908283846199;420.3631498280106;422.85200179937016;440.06266652031167;18374.448766537007;19132.617347653057;19696.507587310323;19848.801511984875;20091.095900684468;18468.815311846876;18979.71530427045;19031.809681903178;19368;19387.515312117204;5224.138017227153;5771.307443106812;5774.82675519735;5779.450952159559;5781.277340332458;5576.302962129734;5587.608867379285;5617.0731829248125;5656.434356564352;5661.094224924013;5434.510894019538;5488.91766623501;5510.614257002011;5538.196961440589;5588.6646801191855;4507.4140361752925;4519.322101684741;5522.447755224485;5525.778968841261;5615.213870058195;5689.288838895138;5745.569082318842;5772.538196944234;5777.913331300034;5783.450572195635;14399.352029158608;14452.855471445257;14480.637984050378;14829.480968166063;14845.628859278497;2617.2802479318148;2681.9731802681918;2789.288731373507;2826.406454644527;2876.755475784561;9942.154916832078;10455.797583277945;10502.632407865687;10737.24839261252;10879.83680244797;1978.6537355962794;1993.6710442776925;2061.2682497713245;2086.4158035750015;2237.3288013595857;58859;87434.56282718545;87825;88992.55503722504;89577;11439.798821123828;11470.541178352772;11472.827907581393;11478.94260528692;11546.94226528862;16410.425635102714;16425.425110121327;16515;16548.586285342964;16572.58568535772;8608.569571521399;8771.386002979858;8888;8929.687460938965;8960.775980600538;8540.316774658013;8596.699115530926;8607.65569377218;8640.26557742599;8768.210861022411;4916.827911023097;5044.545990860766;5046.6719663221775;5069.619778516626;5074.06129865976;2005.8065451056598;2052.92814751483;2076.512019675375;2080.334293026217;2132.530843214521;927.7866090799154;994.1450352696675;1029.9948500257601;1062.102523367753;1095.7917995580815;18613.534661633566;18791;19239.615207695766;19299.228030878607;19534.413967580997;1005.6329439754437;1029.624187171692;1042.145440738587;1057.5875408590655;1082.1721383141903;10117.342372745748;10669.83995240072;10713.571457141783;10766.676999690022;10890.128789696964;413253;413569;417579;511882;527695;67513.66243168752;78882;81221.18778812254;105773;106296.93703063024;1029.248648486609;1068.1401471815263;1070.1224995503612;1075.231209685079;1081.4592703648175;16356.18219089017;16690.833091668926;16912.57718557046;16984.49046528606;17240.827591724425;40557.59442405656;41320.586794132876;41839.37240941449;42115.78942105392;42944.78527607342;57293.42706573047;57471.7126414382;58670.7066464665;59017;60241.69879150576;7179.497435179696;7680.615969201406;8465.407421480437;8496.872546911678;8790.604422801118;11795.35125568102;12770.169938953939;13064.020198485341;13224.938171055146;13414.262215577846;11490.425478726198;11619.883801161881;11644.941775291069;11871.643850684493;11924.463399147233;11381.658550243506;11400.771984560428;11495.195336326376;11523.884761152616;11848.70378240551;11614.245074070159;11807.173497855068;11986.160968732105;12071.818922715991;12324.445399956845;8684.43551169172;8807.779805504657;8887.294755300556;8896.199342059246;9137.588808503766;9215.170634642915;11414;11701.590444334408;11711.414429278673;11899.524019039141 06:37:43 INFO - PROCESS | 24134 | |3;mootools.html;1381.9654508637288;1551;1576.4324843056502;1758.8417042466176;1873.0634682658679;8451.53516556589;8920.776980575489;8937.972133204683;9154.359194856363;9160.816783664322;8927.55362231889;9115.77210569736;9117.544122793866;9119.042500537447;9120;2105.957880842382;2342.4612339162004;2367.5264947010623;2399.016403274658;2408.337707130536;2419.1532963462823;2425.915092971746;2426.793722533587;2435.196385192882;2436.3665446983823;2372.347604408793;2424.648425978232;2425.151197081025;2425.915092971746;2431.416460049584;2083.208380815288;2338.9532209355802;2389.319044072431;2395.4490467192645;2409.0484258717884;2306.5386922615544;2318.2233951626226;2325.1164557468055;2326.174208156097;2329.429289823987;8983.910160898438;9114.726558203265;9126.315526335486;9126.68056618022;9137.269018478506;5231.816886408996;5358.062339090644;5367.7316134193525;5371.57027437804;5373.811916582901;3396;3546.964530354689;3555.5022296878456;3579.1410061585293;3595.622459641726;1148.2995372822572;1201.495371943777;1217.4643157010887;1224.179799534314;1226.2948804437394;12789.936050319782;12823.487060517567;12841.036922230871;12841.036922230871;12858.549950751772;4598.471175814824;4670.206064968964;4706.552877476634;4738.8341408050555;4776.665633405698;10659.467026648637;10726.463676816284;10741.140708743282;10756.623518176826;10757.9462102689;4892.217245240744;5303.522682958553;5310.389305229871;5311.575073994071;5316.415194328621;4748.121597504472;4902.240152776254;4939.506049395031;4950.529699678525;4976.402831660224;4247.5964783345535;4253.638440732572;4261.955820823918;4291.592298731615;4294.3558466230315;1294.449858810002;1337;1337.7057047449546;1344.4487760018346;1352.6212660455087;1049.1763965287366;1056.3028401255135;1057.0644979193469;1058.227493929436;1061.0927656853435;6251;6379.808605741835;6494.4479719223455;6530.738770449128;6626.635535045619;984.9064338887795;1001.3591301567003;1003.7039073473343;1035.699647102332;1047.7694907120422;4401.405810215644;4418.80115394808;4500.032493014018;4505.324201369821;4526.6152377047665;11688.70778230551;11854.288742675468;11989.700257493632;12078.51685932553;12126.636200913987;11799.35103569312;11868.643940681794;11887;11906.166568340306;11908.225965312227;8257.628406721591;8612.48325100496;8777.473351598925;8782.736517904474;8795.340349473816;6350.713243837883;6552.541322107407;6574.671266436755;6609.4712423005085;6648.135742353463;10596.576136954436;10831.783364332827;10925.453727313761;11016.394098324668;11065.723356916142;10754.408507531847;11085.44572771342;11137.891285797523;11230.382328971986;11246;7513.8497230054;7708.845823083395;7716.5370077795515;8190.50856948585;8391.874121888055;8418.579071046546;8761.956190219264;8949.239314658327;8998.23515001206;9231.538423078953;8117.512949223065;8297.128801475757;8311.667533298842;8344.707935222237;8506.06433292325;8062.798430039062;8182.631781569725;8222.671093156207;8280.337572994267;8302.294304984143;7399.778006659809;7442.9255707442235;7657.46397752152;7661.348785353307;7662.157162711986;5392.245085687929;5417.174360306121;5467.835964921059;5477.178423236546;5479.068558345011;5356.732163391737;5362.892742145214;5402.918956215739;5444.754986025559;5534.4742249486235 06:37:43 INFO - PROCESS | 24134 | |4;prototype.html;353.37099962067515;354.7126827269911;362.5431955735773;366.6974745834687;368.3517010062293;5404.243405923174;5448.564114870811;5449.564034877215;5449.891002179954;5460.31746031746;5302.761375738091;5318.813841515548;5375.75809088591;5384;5410.1073322901775;3933.7970736387715;4050.513938327405;4288.6140247377725;4291.9570804292025;4325.156594464081;4251.958270223799;4270.274053410928;4287.399764033038;4294.828206871737;4306.600354884675;4131.876043718693;4273.850415235467;4276;4291.978540107295;4344.717593356421;4156.898421918194;4249.298865687158;4255.361695745632;4261.893452663693;4288.892777680583;3751.118487155516;3762.9247415051545;3772.7170462215167;3776.565694945089;3788.8105594720155;5158.458361872024;5200.323957885488;5223.608229382811;5227.163653815372;5272;4841.927371089437;4842.709437433765;4866.489018653061;4874.36708702585;4884.241672997718;5388.568914486871;5516.475934786189;5533;5621.353544342412;5642.520385767215;4051.372037334218;4070.653994410479;4116.567760385146;4177.728447650893;4231.682623803196;5666.121751128581;5776.797812076557;5792.7972520961985;5808.9793307480295;5820.729915333023;4097.672186225095;4157.792110394468;4192.224438478891;4221.451211342506;4254.361845723104;4208.431861698693;4261.914761704748;4271.807768650418;4281.186574550826;4290.270653988767;4861.927071093936;4885.5847252983895;4901.460839307673;4913.287573301923;4922.458529561745;5624.240727501735;5643.746031428595;5644.096944488862;5649.406812284733;5654.264945557051;1447.768357062886;1506.367325723199;1512.8033355663692;1518.2105305241212;1523.1242035829443;974.5273542331963;977.9755506112405;1006.8288390973552;1009.0817356205818;1014.9949250253701;4879;4901.485344038824;4944.25593795447;4960.950390496048;4990.700557966534;5132.5893928486375;5165.966806638612;5187.106706052339;5199.142141546678;5204.947950520446;4788.25782003783;4856.223004319362;4959.528844759742;4990.476000020019;5022.547970682583;2735.5076086304257;2760.323720688404;2770.4320614274025;2778.4859800936892;2811.6344875166096;5334.759935802898;5344.893102137936;5348.839534813962;5393.30111015029;5398.379186393537;5073.883745575968;5194.298769666047;5218.66078704883;5221.216817477409;5293.232481290268;5304.946950530445;5364.873376590882;5391.843262694953;5819.6614778600315;5985;5775.220345253337;5796.029350021013;5824.650520968756;5828.650280982985;5835.591508594358;5700.885982280248;5712.571557133315;5714.542836572981;5754.913676294943;5757.827265182052;5806.970965145148;6034.094885766995;6055.122007308827;6058.848528786815;6066.332703402711;4288.571142885687;4308.612224899774;4325.74045557255;4327.961289290484;4328.696991210585;5656.179853921076;5711.3431955324;5807.780366123162;5814.273215848019;5820.621659592113;5599.468050535193;5600.43995600453;5631.915521267266;5653.773849045992;5675.290588676416;5551.666899986014;5642.379338272869;5671.625382897169;5682.147677848356;5697.857553561028;5260.658057226268;5614.29821272341;5620.74706638194;5643.7742490299925;5648.333741546336;5722.370539240764;5730.627509211888;5741.511971482304;5746.339170995389;5757.309122905278;5507.807226747044;5614.831555053355;5637.689927054052;5637.9718101409235;5661.980843448054 06:37:43 INFO - PROCESS | 24134 | |5;yui.html;762.5081822224662;810.3517186250998;844.674800201922;863.9049704532504;939.5537119868061;14666.413343466274;14688.999999999987;14733;15729.37082516698;18065.81934180658;17156.485305440827;17287;17384;17425;17430.738538921894;731.2650785960103;869.5652173913044;872.0189786490198;877.1228771228771;877.8814859993915;852.4629483425433;875.3478658399501;882;883.7216276872797;884.3146561414891;898.3980732908967;904.317240483434;904.5115637555712;905.3888625178012;913.3469569257979;748.2218492767515;767.2787579675088;896.9641214351418;897.1970086772335;897.9461232326049;570.1447828257614;652.3378770547897;670.7149461478851;673.5419914458166;681.9352161544646;16574.337026518926;16602.83397166025;16607.750883736753;16634.58413539659;16660.58348541284;14523.927380363137;15055.924720376437;15117.54647360581;15134.470293539673;15234;13974.58076257714;14314.42742290307;14469.855301446956;14479.855201447956;14815.777763333559;4756.167670657655;4786.473487916326;4815.614750819961;4828.686135401223;4838.225883858566;80242.59878700628;80501.59749201275;80523.59738201271;80546;81395.5930220351;11176.329420234812;11286.435678216056;11333.716657083638;11736.471858766376;11957.28256304607;21318.467038324165;21424.571508570054;21424.892875535523;21479.570408591742;21480.355589332346;8499.447535910145;8554.315654747605;8625.13748625145;8642;8657.39398242117;4719.976400117977;4749.3588365570895;4820.3492528508905;4890.804367825247;5069.746512674352;3681.1901381695984;3874.7481413708583;3885.048163200034;3909.7263191576317;3914.041059940333;618.3877960818756;623.8627501949563;629.471244154912;639.6929473852484;644.0210879463283;683.5625199872086;697.5047716121509;700.7477308169055;706.9151701795818;726.7674344209908;9506.90493095074;9634;9668.661596844076;9719.951400242953;9809.166220871306;608.984775380619;674.2448457727377;687.9036934829128;695.6382681005848;703.3880523944201;4465.218586747306;4545.114152059632;4559.726416415026;4654.86035418938;4698.976505117453;118088.40955795166;119491;119644;119903;121968.39015804864;67883.66058169777;78743;100050.4997475008;102239.488802557;104560;88464;89230;89550;89590.55204724065;89835.10164898398;9109.863352049857;9176;9258.95370523143;9314.813703726024;9429.905700942903;53998.73000634972;54438.727806360715;54684.453155467934;55261;56146.71926640341;53233;78202.6089869547;78922.6053869727;79094.20905790868;79256;11443.942780286377;11749.118816088656;12455.750884982432;12486.319818896847;12489.500419983098;13295.734085318432;13370.933145334211;13566.118202317213;13615.25116118623;13822.308884555932;12196.451159697657;12409;12848.871511284768;13009.609711708665;13136.408861601441;14635.634109147357;14873.256337183315;15137.545873623809;15212.46756363522;15252.237388130327;13940;14040.578782636538;14150.504732334319;14354.784678230044;14819.110853348833;11402;11458.71353216143;11513.172652725572;11547.595834146101;11566.826497602375;11592.130590205938;11734.295942243492;11824.527018919147;11877.22798018126;12131.878681213075 06:37:43 INFO - PROCESS | 24134 | __end_tp_report 06:37:43 INFO - PROCESS | 24134 | __start_cc_report 06:37:43 INFO - PROCESS | 24134 | _x_x_mozilla_cycle_collect,850 06:37:43 INFO - PROCESS | 24134 | __end_cc_report 06:37:43 INFO - PROCESS | 24134 | __startTimestamp1469453863176__endTimestamp 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | ------- Summary: start ------- 06:37:43 INFO - PROCESS | 24134 | Number of tests: 6 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | [#0] dojo.html Cycles:165 Average:5538.74 Median:5728.46 stddev:617.60 (10.8%) stddev-sans-first:594.45 06:37:43 INFO - PROCESS | 24134 | Values: 3319.5 3328.5 3352.4 3354.6 3394.7 5461.8 5518.4 5560.3 5566.3 5587.1 5545.9 5644.8 5647.7 5654.1 5679.7 4998.3 5113.5 5140.7 5172.8 5217.1 5021.1 5168.9 5207.0 5207.3 5211.9 5056.4 5092.4 5123.3 5125.4 5170.6 5119.2 5132.7 5144.8 5147.0 5147.1 4959.9 5024.9 5037.1 5057.0 5057.2 5328.5 5340.8 5363.0 5384.4 5397.7 5896.6 5901.4 5907.3 5913.1 5913.6 5905.4 5921.7 5949.5 5974.3 5996.5 5628.5 5643.2 5669.2 5672.3 5683.6 5800.8 6130.0 6145.2 6145.6 6149.3 5797.7 5891.1 5932.9 5953.2 5959.1 6011.5 6018.0 6023.8 6051.1 6054.4 5714.9 5777.2 5985.2 5994.2 6006.3 5728.5 5841.6 5850.2 5853.5 5892.2 4516.1 4518.8 4529.3 4530.0 4554.8 3989.4 4022.9 4033.9 4036.6 4078.0 5679.3 5684.2 5698.3 5705.6 5734.1 5972.9 5982.6 5985.3 5997.2 6020.6 5456.6 5589.9 5634.2 5640.2 5674.7 5079.2 5081.5 5084.7 5090.2 5110.1 6220.0 6231.7 6236.1 6241.8 6244.3 5699.5 5930.1 5969.3 5976.1 5981.8 6226.7 6238.2 6266.5 6279.8 6286.7 5896.5 5910.9 5919.9 5925.6 5949.8 5750.6 5881.2 5939.1 5952.9 6003.7 5848.9 5849.8 5850.5 5865.5 5868.3 5593.5 5799.3 5842.8 5857.2 5862.1 5623.0 5677.1 5686.1 5732.5 5737.3 5807.2 5839.6 5881.0 5882.6 5884.8 5580.7 5627.6 5744.7 5750.2 5762.8 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | [#1] ext.html Cycles:180 Average:67367.08 Median:39450.01 stddev:139751.64 (354.2%) stddev-sans-first:140053.78 06:37:43 INFO - PROCESS | 24134 | Values: 605.3 637.1 642.8 664.7 677.1 33432.5 45740.3 46458.5 46500.1 46572.0 48519.3 48902.0 48947.3 49016.3 49075.3 8319.3 9022.2 9159.3 9167.0 10614.3 10749.0 10858.0 10858.5 10864.1 10877.3 10616.9 10653.5 10655.6 10664.3 10680.8 8224.3 8330.1 10724.0 10887.3 10968.5 10386.7 10520.4 10522.8 10538.8 10540.8 45366.8 45836.5 45859.8 45920.0 45998.8 3540.3 3584.6 3712.6 3724.2 3812.3 34948.3 35246.6 35604.5 36306.6 36371.8 4555.6 4570.3 4623.2 4727.1 4795.5 404194.0 405880.0 406281.0 406536.0 407094.0 38693.8 71752.6 72249.3 72267.0 72354.6 39585.8 41642.4 41681.6 41691.4 41715.8 17555.8 17828.4 17832.7 17836.7 17841.7 13389.9 14404.4 14515.9 14542.3 15030.2 9124.4 9132.0 9173.1 9220.8 9249.6 3488.6 3552.4 3575.1 3576.6 3603.6 1010.4 1073.1 1090.9 1151.2 1156.4 33878.3 33969.5 34290.8 34651.3 35073.3 1196.7 1214.9 1250.5 1254.0 1268.0 17620.5 17917.6 18153.8 18200.2 18273.5 637900.0 643492.0 650360.0 652746.0 656907.0 64353.4 64996.4 65026.0 65090.7 65270.3 1340.6 1420.7 1462.8 1476.0 1482.4 34338.8 35159.0 35661.8 35849.5 36031.3 53144.7 53748.0 53753.5 53790.7 53947.2 489150.0 489899.0 490094.0 491263.0 491691.0 27598.7 30089.7 30874.7 31018.7 32335.8 51352.5 52622.7 53081.0 53499.0 53652.7 43377.1 43384.0 43600.3 44371.6 44420.6 43397.8 43776.6 44453.6 44600.3 44909.8 44332.0 45165.1 45436.0 45567.0 45616.3 37592.2 37968.6 38636.2 38969.0 39314.2 29348.2 29475.6 29515.1 29586.3 29601.6 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | [#2] jquery.html Cycles:180 Average:27849.21 Median:2109.47 stddev:76029.93 (3604.2%) stddev-sans-first:76215.32 06:37:43 INFO - PROCESS | 24134 | Values: 419.6 419.9 420.4 422.9 440.1 18374.4 19132.6 19696.5 19848.8 20091.1 18468.8 18979.7 19031.8 19368.0 19387.5 5224.1 5771.3 5774.8 5779.5 5781.3 5576.3 5587.6 5617.1 5656.4 5661.1 5434.5 5488.9 5510.6 5538.2 5588.7 4507.4 4519.3 5522.4 5525.8 5615.2 5689.3 5745.6 5772.5 5777.9 5783.5 14399.4 14452.9 14480.6 14829.5 14845.6 2617.3 2682.0 2789.3 2826.4 2876.8 9942.2 10455.8 10502.6 10737.2 10879.8 1978.7 1993.7 2061.3 2086.4 2237.3 58859.0 87434.6 87825.0 88992.6 89577.0 11439.8 11470.5 11472.8 11478.9 11546.9 16410.4 16425.4 16515.0 16548.6 16572.6 8608.6 8771.4 8888.0 8929.7 8960.8 8540.3 8596.7 8607.7 8640.3 8768.2 4916.8 5044.5 5046.7 5069.6 5074.1 2005.8 2052.9 2076.5 2080.3 2132.5 927.8 994.1 1030.0 1062.1 1095.8 18613.5 18791.0 19239.6 19299.2 19534.4 1005.6 1029.6 1042.1 1057.6 1082.2 10117.3 10669.8 10713.6 10766.7 10890.1 413253.0 413569.0 417579.0 511882.0 527695.0 67513.7 78882.0 81221.2 105773.0 106296.9 1029.2 1068.1 1070.1 1075.2 1081.5 16356.2 16690.8 16912.6 16984.5 17240.8 40557.6 41320.6 41839.4 42115.8 42944.8 57293.4 57471.7 58670.7 59017.0 60241.7 7179.5 7680.6 8465.4 8496.9 8790.6 11795.4 12770.2 13064.0 13224.9 13414.3 11490.4 11619.9 11644.9 11871.6 11924.5 11381.7 11400.8 11495.2 11523.9 11848.7 11614.2 11807.2 11986.2 12071.8 12324.4 8684.4 8807.8 8887.3 8896.2 9137.6 9215.2 11414.0 11701.6 11711.4 11899.5 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | [#3] mootools.html Cycles:180 Average:6120.48 Median:4459.42 stddev:3520.82 (79.0%) stddev-sans-first:3512.69 06:37:43 INFO - PROCESS | 24134 | Values: 1382.0 1551.0 1576.4 1758.8 1873.1 8451.5 8920.8 8938.0 9154.4 9160.8 8927.6 9115.8 9117.5 9119.0 9120.0 2106.0 2342.5 2367.5 2399.0 2408.3 2419.2 2425.9 2426.8 2435.2 2436.4 2372.3 2424.6 2425.2 2425.9 2431.4 2083.2 2339.0 2389.3 2395.4 2409.0 2306.5 2318.2 2325.1 2326.2 2329.4 8983.9 9114.7 9126.3 9126.7 9137.3 5231.8 5358.1 5367.7 5371.6 5373.8 3396.0 3547.0 3555.5 3579.1 3595.6 1148.3 1201.5 1217.5 1224.2 1226.3 12789.9 12823.5 12841.0 12841.0 12858.5 4598.5 4670.2 4706.6 4738.8 4776.7 10659.5 10726.5 10741.1 10756.6 10757.9 4892.2 5303.5 5310.4 5311.6 5316.4 4748.1 4902.2 4939.5 4950.5 4976.4 4247.6 4253.6 4262.0 4291.6 4294.4 1294.4 1337.0 1337.7 1344.4 1352.6 1049.2 1056.3 1057.1 1058.2 1061.1 6251.0 6379.8 6494.4 6530.7 6626.6 984.9 1001.4 1003.7 1035.7 1047.8 4401.4 4418.8 4500.0 4505.3 4526.6 11688.7 11854.3 11989.7 12078.5 12126.6 11799.4 11868.6 11887.0 11906.2 11908.2 8257.6 8612.5 8777.5 8782.7 8795.3 6350.7 6552.5 6574.7 6609.5 6648.1 10596.6 10831.8 10925.5 11016.4 11065.7 10754.4 11085.4 11137.9 11230.4 11246.0 7513.8 7708.8 7716.5 8190.5 8391.9 8418.6 8762.0 8949.2 8998.2 9231.5 8117.5 8297.1 8311.7 8344.7 8506.1 8062.8 8182.6 8222.7 8280.3 8302.3 7399.8 7442.9 7657.5 7661.3 7662.2 5392.2 5417.2 5467.8 5477.2 5479.1 5356.7 5362.9 5402.9 5444.8 5534.5 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | [#4] prototype.html Cycles:180 Average:4685.12 Median:5202.64 stddev:1344.42 (25.8%) stddev-sans-first:1308.29 06:37:43 INFO - PROCESS | 24134 | Values: 353.4 354.7 362.5 366.7 368.4 5404.2 5448.6 5449.6 5449.9 5460.3 5302.8 5318.8 5375.8 5384.0 5410.1 3933.8 4050.5 4288.6 4292.0 4325.2 4252.0 4270.3 4287.4 4294.8 4306.6 4131.9 4273.9 4276.0 4292.0 4344.7 4156.9 4249.3 4255.4 4261.9 4288.9 3751.1 3762.9 3772.7 3776.6 3788.8 5158.5 5200.3 5223.6 5227.2 5272.0 4841.9 4842.7 4866.5 4874.4 4884.2 5388.6 5516.5 5533.0 5621.4 5642.5 4051.4 4070.7 4116.6 4177.7 4231.7 5666.1 5776.8 5792.8 5809.0 5820.7 4097.7 4157.8 4192.2 4221.5 4254.4 4208.4 4261.9 4271.8 4281.2 4290.3 4861.9 4885.6 4901.5 4913.3 4922.5 5624.2 5643.7 5644.1 5649.4 5654.3 1447.8 1506.4 1512.8 1518.2 1523.1 974.5 978.0 1006.8 1009.1 1015.0 4879.0 4901.5 4944.3 4961.0 4990.7 5132.6 5166.0 5187.1 5199.1 5204.9 4788.3 4856.2 4959.5 4990.5 5022.5 2735.5 2760.3 2770.4 2778.5 2811.6 5334.8 5344.9 5348.8 5393.3 5398.4 5073.9 5194.3 5218.7 5221.2 5293.2 5304.9 5364.9 5391.8 5819.7 5985.0 5775.2 5796.0 5824.7 5828.7 5835.6 5700.9 5712.6 5714.5 5754.9 5757.8 5807.0 6034.1 6055.1 6058.8 6066.3 4288.6 4308.6 4325.7 4328.0 4328.7 5656.2 5711.3 5807.8 5814.3 5820.6 5599.5 5600.4 5631.9 5653.8 5675.3 5551.7 5642.4 5671.6 5682.1 5697.9 5260.7 5614.3 5620.7 5643.8 5648.3 5722.4 5730.6 5741.5 5746.3 5757.3 5507.8 5614.8 5637.7 5638.0 5662.0 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - PROCESS | 24134 | [#5] yui.html Cycles:180 Average:21238.64 Median:4771.32 stddev:30353.12 (636.2%) stddev-sans-first:30399.33 06:37:43 INFO - PROCESS | 24134 | Values: 762.5 810.4 844.7 863.9 939.6 14666.4 14689.0 14733.0 15729.4 18065.8 17156.5 17287.0 17384.0 17425.0 17430.7 731.3 869.6 872.0 877.1 877.9 852.5 875.3 882.0 883.7 884.3 898.4 904.3 904.5 905.4 913.3 748.2 767.3 897.0 897.2 897.9 570.1 652.3 670.7 673.5 681.9 16574.3 16602.8 16607.8 16634.6 16660.6 14523.9 15055.9 15117.5 15134.5 15234.0 13974.6 14314.4 14469.9 14479.9 14815.8 4756.2 4786.5 4815.6 4828.7 4838.2 80242.6 80501.6 80523.6 80546.0 81395.6 11176.3 11286.4 11333.7 11736.5 11957.3 21318.5 21424.6 21424.9 21479.6 21480.4 8499.4 8554.3 8625.1 8642.0 8657.4 4720.0 4749.4 4820.3 4890.8 5069.7 3681.2 3874.7 3885.0 3909.7 3914.0 618.4 623.9 629.5 639.7 644.0 683.6 697.5 700.7 706.9 726.8 9506.9 9634.0 9668.7 9720.0 9809.2 609.0 674.2 687.9 695.6 703.4 4465.2 4545.1 4559.7 4654.9 4699.0 118088.4 119491.0 119644.0 119903.0 121968.4 67883.7 78743.0 100050.5 102239.5 104560.0 88464.0 89230.0 89550.0 89590.6 89835.1 9109.9 9176.0 9259.0 9314.8 9429.9 53998.7 54438.7 54684.5 55261.0 56146.7 53233.0 78202.6 78922.6 79094.2 79256.0 11443.9 11749.1 12455.8 12486.3 12489.5 13295.7 13370.9 13566.1 13615.3 13822.3 12196.5 12409.0 12848.9 13009.6 13136.4 14635.6 14873.3 15137.5 15212.5 15252.2 13940.0 14040.6 14150.5 14354.8 14819.1 11402.0 11458.7 11513.2 11547.6 11566.8 11592.1 11734.3 11824.5 11877.2 12131.9 06:37:43 INFO - PROCESS | 24134 | -------- Summary: end -------- 06:37:43 INFO - PROCESS | 24134 | 06:37:43 INFO - TEST-INFO | 24134: exit 0 06:37:43 INFO - TEST-OK | dromaeo_css | took 1112096ms 06:37:43 INFO - TEST-START | kraken 06:37:43 INFO - operating with platform_type : linux_ 06:37:43 INFO - Initialising browser for kraken test... 06:37:43 INFO - TEST-INFO | started process 24326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCWjMX3/profile http://localhost:57124/getInfo.html) 06:37:47 INFO - PROCESS | 24326 | __metrics Screen width/height:1600/1200 06:37:47 INFO - PROCESS | 24326 | colorDepth:24 06:37:47 INFO - PROCESS | 24326 | Browser inner width/height: 1024/697 06:37:47 INFO - PROCESS | 24326 | __metrics 06:37:48 INFO - PROCESS | 24326 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:37:48 ERROR - PROCESS | 24326 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:37:48 INFO - TEST-INFO | 24326: exit 0 06:37:48 INFO - Browser initialized. 06:37:48 INFO - Running cycle 1/1 for kraken test... 06:37:48 INFO - TEST-INFO | started process 24418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCWjMX3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:00 INFO - PROCESS | 24418 | RSS: Main: 145178624 06:38:00 INFO - PROCESS | 24418 | 06:38:03 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:04 INFO - PROCESS | 24418 | RSS: Main: 194871296 06:38:04 INFO - PROCESS | 24418 | 06:38:06 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-dft) 06:38:07 INFO - PROCESS | 24418 | RSS: Main: 193863680 06:38:07 INFO - PROCESS | 24418 | 06:38:10 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-fft) 06:38:10 INFO - PROCESS | 24418 | RSS: Main: 279011328 06:38:10 INFO - PROCESS | 24418 | 06:38:12 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-oscillator) 06:38:13 INFO - PROCESS | 24418 | RSS: Main: 188157952 06:38:13 INFO - PROCESS | 24418 | 06:38:15 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:16 INFO - PROCESS | 24418 | RSS: Main: 188657664 06:38:16 INFO - PROCESS | 24418 | 06:38:19 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57124/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:19 INFO - PROCESS | 24418 | RSS: Main: 223158272 06:38:19 INFO - PROCESS | 24418 | 06:38:23 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57124/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:23 INFO - PROCESS | 24418 | RSS: Main: 223092736 06:38:23 INFO - PROCESS | 24418 | 06:38:26 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57124/tests/kraken/driver.html?testName=json-parse-financial) 06:38:27 INFO - PROCESS | 24418 | RSS: Main: 223113216 06:38:27 INFO - PROCESS | 24418 | 06:38:28 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:29 INFO - PROCESS | 24418 | RSS: Main: 201375744 06:38:29 INFO - PROCESS | 24418 | 06:38:30 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:31 INFO - PROCESS | 24418 | RSS: Main: 201236480 06:38:31 INFO - PROCESS | 24418 | 06:38:33 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:34 INFO - PROCESS | 24418 | RSS: Main: 210153472 06:38:34 INFO - PROCESS | 24418 | 06:38:36 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:37 INFO - PROCESS | 24418 | RSS: Main: 216584192 06:38:37 INFO - PROCESS | 24418 | 06:38:39 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:40 INFO - PROCESS | 24418 | RSS: Main: 212811776 06:38:40 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57124/tests/kraken/driver.html?testName=ai-astar) 06:38:42 INFO - PROCESS | 24418 | RSS: Main: 255684608 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | __start_tp_report 06:38:42 INFO - PROCESS | 24418 | _x_x_mozilla_page_load 06:38:42 INFO - PROCESS | 24418 | _x_x_mozilla_page_load_details 06:38:42 INFO - PROCESS | 24418 | |i|pagename|runs| 06:38:42 INFO - PROCESS | 24418 | |0;ai-astar;111;104;111;112;110;109;108;108;111;109 06:38:42 INFO - PROCESS | 24418 | |1;audio-beat-detection;149;123;128;180;125;128;153;125;156;130 06:38:42 INFO - PROCESS | 24418 | |2;audio-dft;160;161;161;160;160;159;160;159;159;160 06:38:42 INFO - PROCESS | 24418 | |3;audio-fft;75;74;76;125;75;76;75;74;106;74 06:38:42 INFO - PROCESS | 24418 | |4;audio-oscillator;83;84;115;85;84;85;119;84;84;123 06:38:42 INFO - PROCESS | 24418 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;117;117;117 06:38:42 INFO - PROCESS | 24418 | |6;imaging-darkroom;146;147;146;146;146;147;145;192;147;147 06:38:42 INFO - PROCESS | 24418 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 06:38:42 INFO - PROCESS | 24418 | |8;json-parse-financial;51;49;50;52;51;52;52;51;51;51 06:38:42 INFO - PROCESS | 24418 | |9;json-stringify-tinderbox;58;60;58;59;59;60;59;59;60;59 06:38:42 INFO - PROCESS | 24418 | |10;stanford-crypto-aes;80;77;76;76;77;79;83;77;104;79 06:38:42 INFO - PROCESS | 24418 | |11;stanford-crypto-ccm;121;118;118;115;119;121;117;118;129;119 06:38:42 INFO - PROCESS | 24418 | |12;stanford-crypto-pbkdf2;154;155;154;155;155;152;152;156;152;155 06:38:42 INFO - PROCESS | 24418 | |13;stanford-crypto-sha256-iterative;61;63;60;60;62;61;60;59;62;61 06:38:42 INFO - PROCESS | 24418 | __end_tp_report 06:38:42 INFO - PROCESS | 24418 | __start_cc_report 06:38:42 INFO - PROCESS | 24418 | _x_x_mozilla_cycle_collect,1562 06:38:42 INFO - PROCESS | 24418 | __end_cc_report 06:38:42 INFO - PROCESS | 24418 | __startTimestamp1469453922365__endTimestamp 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | ------- Summary: start ------- 06:38:42 INFO - PROCESS | 24418 | Number of tests: 14 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:2.31 (2.1%) stddev-sans-first:2.37 06:38:42 INFO - PROCESS | 24418 | Values: 111.0 104.0 111.0 112.0 110.0 109.0 108.0 108.0 111.0 109.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:139.50 stddev:18.95 (13.6%) stddev-sans-first:19.80 06:38:42 INFO - PROCESS | 24418 | Values: 149.0 123.0 128.0 180.0 125.0 128.0 153.0 125.0 156.0 130.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 06:38:42 INFO - PROCESS | 24418 | Values: 160.0 161.0 161.0 160.0 160.0 159.0 160.0 159.0 159.0 160.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:17.72 (23.6%) stddev-sans-first:18.56 06:38:42 INFO - PROCESS | 24418 | Values: 75.0 74.0 76.0 125.0 75.0 76.0 75.0 74.0 106.0 74.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:16.95 (20.2%) stddev-sans-first:17.45 06:38:42 INFO - PROCESS | 24418 | Values: 83.0 84.0 115.0 85.0 84.0 85.0 119.0 84.0 84.0 123.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:38:42 INFO - PROCESS | 24418 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:147.00 stddev:14.46 (9.8%) stddev-sans-first:15.22 06:38:42 INFO - PROCESS | 24418 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 145.0 192.0 147.0 147.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 06:38:42 INFO - PROCESS | 24418 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 06:38:42 INFO - PROCESS | 24418 | Values: 51.0 49.0 50.0 52.0 51.0 52.0 52.0 51.0 51.0 51.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 06:38:42 INFO - PROCESS | 24418 | Values: 58.0 60.0 58.0 59.0 59.0 60.0 59.0 59.0 60.0 59.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:78.00 stddev:8.43 (10.8%) stddev-sans-first:8.94 06:38:42 INFO - PROCESS | 24418 | Values: 80.0 77.0 76.0 76.0 77.0 79.0 83.0 77.0 104.0 79.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:119.00 stddev:3.78 (3.2%) stddev-sans-first:3.97 06:38:42 INFO - PROCESS | 24418 | Values: 121.0 118.0 118.0 115.0 119.0 121.0 117.0 118.0 129.0 119.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:155.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 06:38:42 INFO - PROCESS | 24418 | Values: 154.0 155.0 154.0 155.0 155.0 152.0 152.0 156.0 152.0 155.0 06:38:42 INFO - PROCESS | 24418 | 06:38:42 INFO - PROCESS | 24418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.00 stddev:1.20 (2.0%) stddev-sans-first:1.27 06:38:42 INFO - PROCESS | 24418 | Values: 61.0 63.0 60.0 60.0 62.0 61.0 60.0 59.0 62.0 61.0 06:38:42 INFO - PROCESS | 24418 | -------- Summary: end -------- 06:38:42 INFO - PROCESS | 24418 | 06:38:43 INFO - TEST-INFO | 24418: exit 0 06:38:43 INFO - TEST-OK | kraken | took 59469ms 06:38:43 INFO - SUITE-END | took 1171s 06:38:43 INFO - Completed test suite (00:19:31) 06:38:43 INFO - javascript benchmark 06:38:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.4688849784025, 3328.5173649820777, 3352.379809735199, 3354.64776198499, 3394.6944774970248, 5461.754221060052, 5518.365387980383, 5560.277163968683, 5566.276384070075, 5587.133994230896, 5545.916811247825, 5644.8306550803545, 5647.661140331573, 5654.067078931971, 5679.687617181054, 4998.250262460624, 5113.488651134894, 5140.742962851842, 5172.793088276483, 5217.060929032773, 5021.1213037718435, 5168.948310516903, 5206.973965130169, 5207.297014902996, 5211.869703257411, 5056.418511871145, 5092.388913330406, 5123.333966584339, 5125.410577783566, 5170.586353091744, 5119.2321151827155, 5132.666376685522, 5144.819931302424, 5146.974265128688, 5147.073526765181, 4959.925601115986, 5024.874378140539, 5037.093323201822, 5057.0, 5057.216131499624, 5328.46715328468, 5340.786368545254, 5362.973185134088, 5384.353877534721, 5397.676139431607, 5896.646201227897, 5901.380355062743, 5907.320658124328, 5913.113033045078, 5913.556483263773, 5905.438983296623, 5921.674307913063, 5949.524038076944, 5974.312954010301, 5996.4603185713495, 5628.549716022709, 5643.153526970947, 5669.206311116447, 5672.290963629546, 5683.630564013409, 5800.796972106041, 6130.049842274455, 6145.231846019247, 6145.631262124287, 6149.292831324455, 5797.710114494258, 5891.05743081105, 5932.940670593325, 5953.166556682068, 5959.0763431668165, 6011.458968692838, 6017.969910150421, 6023.849403764853, 6051.062085376773, 6054.3945605439985, 5714.885702285931, 5777.2200752897825, 5985.221921150222, 5994.22075130239, 6006.339302676702, 5728.455796699307, 5841.591088623755, 5850.180974663551, 5853.473187413153, 5892.234009578728, 4516.051629157848, 4518.751468669255, 4529.275315949432, 4529.954700452953, 4554.817807287672, 3989.4215338775716, 4022.8793136205377, 4033.9193216135513, 4036.555978842325, 4077.9796101019897, 5679.261695979496, 5684.175794509773, 5698.287714035746, 5705.5720820938595, 5734.139879018181, 5972.880542389128, 5982.641041537521, 5985.34161242263, 5997.160397544348, 6020.638761674313, 5456.590755693339, 5589.944100559023, 5634.183043458757, 5640.153976903415, 5674.687892165888, 5079.161938280216, 5081.542661160439, 5084.720340381315, 5090.2364645303505, 5110.131277682803, 6220.03589443637, 6231.657258850716, 6236.064590311489, 6241.78153764616, 6244.313125556185, 5699.51554117888, 5930.11048342752, 5969.253843269591, 5976.073708575178, 5981.7607295707685, 6226.719797609209, 6238.189035425366, 6266.530010249158, 6279.780207692709, 6286.717097730521, 5896.469317761422, 5910.911336330045, 5919.940800592111, 5925.555583331181, 5949.8215053548465, 5750.597458178055, 5881.17663527098, 5939.07944268639, 5952.940470595238, 6003.669798161143, 5848.912266315923, 5849.766009359748, 5850.53195744348, 5865.501432378295, 5868.3251426084835, 5593.524550413261, 5799.333076696065, 5842.7662893485485, 5857.150713146485, 5862.149988251765, 5622.971885140548, 5677.148427735872, 5686.061799803151, 5732.455416735404, 5737.282839645044, 5807.245058142415, 5839.562032847469, 5881.0, 5882.647041177543, 5884.7940322088525, 5580.665160090408, 5627.577931655224, 5744.684042377709, 5750.166225897305, 5762.827115186551], "value": 5498.5001425957835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2948315212777, 637.1016866218632, 642.8392901774556, 664.6942406493013, 677.1332694151484, 33432.49851252233, 45740.313895291554, 46458.535414645885, 46500.06999860001, 46572.0, 48519.27221091687, 48902.0, 48947.26579101307, 49016.264756028686, 49075.26387104196, 8319.334453243726, 9022.188003079722, 9159.313051521163, 9167.0, 10614.310069845475, 10749.032587067162, 10858.0, 10858.457077146151, 10864.130869530458, 10877.292975956578, 10616.946915265413, 10653.467326633676, 10655.573777048947, 10664.30682005671, 10680.786384272309, 8224.259816616503, 8330.125336839666, 10724.0, 10887.346759194434, 10968.506417211245, 10386.688399348031, 10520.421376824272, 10522.842157367646, 10538.789224215549, 10540.789184216273, 45366.77316613429, 45836.54163458356, 45859.77070114661, 45920.0, 45998.77000614975, 3540.2565461253166, 3584.5877724061806, 3712.5916149223563, 3724.1992971511254, 3812.2566099610585, 34948.301033979435, 35246.64753352459, 35604.46593301102, 36306.63693363059, 36371.81814090939, 4555.589996900262, 4570.291604801261, 4623.1678297906365, 4727.149113159629, 4795.520447955177, 404194.0, 405879.99999999703, 406281.0, 406536.0, 407094.0, 38693.806530967166, 71752.64123679453, 72249.27750722531, 72267.0, 72354.63822680853, 39585.80207098946, 41642.37536436956, 41681.583184168376, 41691.37462938058, 41715.7914210427, 17555.824441755674, 17828.3760068397, 17832.732509012374, 17836.732449013274, 17841.7323740144, 13389.866101339057, 14404.351804168837, 14515.92742036283, 14542.345594448276, 15030.248487575578, 9124.406913550598, 9131.954340228389, 9173.128552787475, 9220.7694807629, 9249.630014799468, 3488.598811136701, 3552.4138517144897, 3575.0526110580718, 3576.5529308836394, 3603.6216197298904, 1010.4038617215878, 1073.1361254190451, 1090.939998300101, 1151.1826603111883, 1156.4160099150045, 33878.32243355119, 33969.49045764316, 34290.82854585711, 34651.30697386038, 35073.29853402918, 1196.730735584504, 1214.9271043737403, 1250.5373011985623, 1253.9874601254053, 1268.0172866028902, 17620.471385858444, 17917.641647167246, 18153.818461815477, 18200.1809918554, 18273.451796446127, 637900.0, 643492.0, 650360.0, 652746.0, 656907.0, 64353.356466434736, 64996.35003649998, 65026.0, 65090.67454662791, 65270.347296527376, 1340.611222745393, 1420.6897927828136, 1462.817147856518, 1475.9704805904037, 1482.3774014913977, 34338.82830585831, 35159.0, 35661.82169089138, 35849.46225806667, 36031.27937441184, 53144.734276328374, 53748.0, 53753.46246537485, 53790.73104634452, 53947.190792138936, 489150.0, 489899.0, 490094.0, 491263.0, 491691.0, 27598.72401276042, 30089.699103009567, 30874.69125308718, 31018.68981310158, 32335.838320808245, 51352.48647513626, 52622.73688631685, 53081.0, 53499.0, 53652.73173634107, 43377.132457350046, 43384.0, 43600.34599481074, 44371.55628443803, 44420.55579444164, 43397.78301108474, 43776.56223437725, 44453.555464444944, 44600.33099503575, 44909.775451122536, 44332.0, 45165.09669806651, 45436.0, 45567.0, 45616.31575526304, 37592.2481550362, 37968.620313796506, 38636.22727545377, 38969.0, 39314.213715726095, 29348.21191986758, 29475.557866632447, 29515.114546563636, 29586.260343491584, 29601.555976659936], "value": 20829.34572256593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.6433031922868, 419.8908283846199, 420.3631498280106, 422.85200179937016, 440.06266652031167, 18374.448766537007, 19132.617347653057, 19696.507587310323, 19848.801511984875, 20091.095900684468, 18468.815311846876, 18979.71530427045, 19031.809681903178, 19368.0, 19387.515312117204, 5224.138017227153, 5771.307443106812, 5774.82675519735, 5779.450952159559, 5781.277340332458, 5576.302962129734, 5587.608867379285, 5617.0731829248125, 5656.434356564352, 5661.094224924013, 5434.510894019538, 5488.91766623501, 5510.614257002011, 5538.196961440589, 5588.6646801191855, 4507.4140361752925, 4519.322101684741, 5522.447755224485, 5525.778968841261, 5615.213870058195, 5689.288838895138, 5745.569082318842, 5772.538196944234, 5777.913331300034, 5783.450572195635, 14399.352029158608, 14452.855471445257, 14480.637984050378, 14829.480968166063, 14845.628859278497, 2617.2802479318148, 2681.9731802681918, 2789.288731373507, 2826.406454644527, 2876.755475784561, 9942.154916832078, 10455.797583277945, 10502.632407865687, 10737.24839261252, 10879.83680244797, 1978.6537355962794, 1993.6710442776925, 2061.2682497713245, 2086.4158035750015, 2237.3288013595857, 58859.0, 87434.56282718545, 87825.0, 88992.55503722504, 89577.0, 11439.798821123828, 11470.541178352772, 11472.827907581393, 11478.94260528692, 11546.94226528862, 16410.425635102714, 16425.425110121327, 16515.0, 16548.586285342964, 16572.58568535772, 8608.569571521399, 8771.386002979858, 8888.0, 8929.687460938965, 8960.775980600538, 8540.316774658013, 8596.699115530926, 8607.65569377218, 8640.26557742599, 8768.210861022411, 4916.827911023097, 5044.545990860766, 5046.6719663221775, 5069.619778516626, 5074.06129865976, 2005.8065451056598, 2052.92814751483, 2076.512019675375, 2080.334293026217, 2132.530843214521, 927.7866090799154, 994.1450352696675, 1029.9948500257601, 1062.102523367753, 1095.7917995580815, 18613.534661633566, 18791.0, 19239.615207695766, 19299.228030878607, 19534.413967580997, 1005.6329439754437, 1029.624187171692, 1042.145440738587, 1057.5875408590655, 1082.1721383141903, 10117.342372745748, 10669.83995240072, 10713.571457141783, 10766.676999690022, 10890.128789696964, 413253.0, 413569.0, 417579.0, 511882.0, 527695.0, 67513.66243168752, 78882.0, 81221.18778812254, 105773.0, 106296.93703063024, 1029.248648486609, 1068.1401471815263, 1070.1224995503612, 1075.231209685079, 1081.4592703648175, 16356.18219089017, 16690.833091668926, 16912.57718557046, 16984.49046528606, 17240.827591724425, 40557.59442405656, 41320.586794132876, 41839.37240941449, 42115.78942105392, 42944.78527607342, 57293.42706573047, 57471.7126414382, 58670.7066464665, 59017.0, 60241.69879150576, 7179.497435179696, 7680.615969201406, 8465.407421480437, 8496.872546911678, 8790.604422801118, 11795.35125568102, 12770.169938953939, 13064.020198485341, 13224.938171055146, 13414.262215577846, 11490.425478726198, 11619.883801161881, 11644.941775291069, 11871.643850684493, 11924.463399147233, 11381.658550243506, 11400.771984560428, 11495.195336326376, 11523.884761152616, 11848.70378240551, 11614.245074070159, 11807.173497855068, 11986.160968732105, 12071.818922715991, 12324.445399956845, 8684.43551169172, 8807.779805504657, 8887.294755300556, 8896.199342059246, 9137.588808503766, 9215.170634642915, 11414.0, 11701.590444334408, 11711.414429278673, 11899.524019039141], "value": 9234.60933012221, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.9654508637288, 1551.0, 1576.4324843056502, 1758.8417042466176, 1873.0634682658679, 8451.53516556589, 8920.776980575489, 8937.972133204683, 9154.359194856363, 9160.816783664322, 8927.55362231889, 9115.77210569736, 9117.544122793866, 9119.042500537447, 9120.0, 2105.957880842382, 2342.4612339162004, 2367.5264947010623, 2399.016403274658, 2408.337707130536, 2419.1532963462823, 2425.915092971746, 2426.793722533587, 2435.196385192882, 2436.3665446983823, 2372.347604408793, 2424.648425978232, 2425.151197081025, 2425.915092971746, 2431.416460049584, 2083.208380815288, 2338.9532209355802, 2389.319044072431, 2395.4490467192645, 2409.0484258717884, 2306.5386922615544, 2318.2233951626226, 2325.1164557468055, 2326.174208156097, 2329.429289823987, 8983.910160898438, 9114.726558203265, 9126.315526335486, 9126.68056618022, 9137.269018478506, 5231.816886408996, 5358.062339090644, 5367.7316134193525, 5371.57027437804, 5373.811916582901, 3396.0, 3546.964530354689, 3555.5022296878456, 3579.1410061585293, 3595.622459641726, 1148.2995372822572, 1201.495371943777, 1217.4643157010887, 1224.179799534314, 1226.2948804437394, 12789.936050319782, 12823.487060517567, 12841.036922230871, 12841.036922230871, 12858.549950751772, 4598.471175814824, 4670.206064968964, 4706.552877476634, 4738.8341408050555, 4776.665633405698, 10659.467026648637, 10726.463676816284, 10741.140708743282, 10756.623518176826, 10757.9462102689, 4892.217245240744, 5303.522682958553, 5310.389305229871, 5311.575073994071, 5316.415194328621, 4748.121597504472, 4902.240152776254, 4939.506049395031, 4950.529699678525, 4976.402831660224, 4247.5964783345535, 4253.638440732572, 4261.955820823918, 4291.592298731615, 4294.3558466230315, 1294.449858810002, 1337.0, 1337.7057047449546, 1344.4487760018346, 1352.6212660455087, 1049.1763965287366, 1056.3028401255135, 1057.0644979193469, 1058.227493929436, 1061.0927656853435, 6251.0, 6379.808605741835, 6494.4479719223455, 6530.738770449128, 6626.635535045619, 984.9064338887795, 1001.3591301567003, 1003.7039073473343, 1035.699647102332, 1047.7694907120422, 4401.405810215644, 4418.80115394808, 4500.032493014018, 4505.324201369821, 4526.6152377047665, 11688.70778230551, 11854.288742675468, 11989.700257493632, 12078.51685932553, 12126.636200913987, 11799.35103569312, 11868.643940681794, 11887.0, 11906.166568340306, 11908.225965312227, 8257.628406721591, 8612.48325100496, 8777.473351598925, 8782.736517904474, 8795.340349473816, 6350.713243837883, 6552.541322107407, 6574.671266436755, 6609.4712423005085, 6648.135742353463, 10596.576136954436, 10831.783364332827, 10925.453727313761, 11016.394098324668, 11065.723356916142, 10754.408507531847, 11085.44572771342, 11137.891285797523, 11230.382328971986, 11246.0, 7513.8497230054, 7708.845823083395, 7716.5370077795515, 8190.50856948585, 8391.874121888055, 8418.579071046546, 8761.956190219264, 8949.239314658327, 8998.23515001206, 9231.538423078953, 8117.512949223065, 8297.128801475757, 8311.667533298842, 8344.707935222237, 8506.06433292325, 8062.798430039062, 8182.631781569725, 8222.671093156207, 8280.337572994267, 8302.294304984143, 7399.778006659809, 7442.9255707442235, 7657.46397752152, 7661.348785353307, 7662.157162711986, 5392.245085687929, 5417.174360306121, 5467.835964921059, 5477.178423236546, 5479.068558345011, 5356.732163391737, 5362.892742145214, 5402.918956215739, 5444.754986025559, 5534.4742249486235], "value": 4880.403546065721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.37099962067515, 354.7126827269911, 362.5431955735773, 366.6974745834687, 368.3517010062293, 5404.243405923174, 5448.564114870811, 5449.564034877215, 5449.891002179954, 5460.31746031746, 5302.761375738091, 5318.813841515548, 5375.75809088591, 5384.0, 5410.1073322901775, 3933.7970736387715, 4050.513938327405, 4288.6140247377725, 4291.9570804292025, 4325.156594464081, 4251.958270223799, 4270.274053410928, 4287.399764033038, 4294.828206871737, 4306.600354884675, 4131.876043718693, 4273.850415235467, 4276.0, 4291.978540107295, 4344.717593356421, 4156.898421918194, 4249.298865687158, 4255.361695745632, 4261.893452663693, 4288.892777680583, 3751.118487155516, 3762.9247415051545, 3772.7170462215167, 3776.565694945089, 3788.8105594720155, 5158.458361872024, 5200.323957885488, 5223.608229382811, 5227.163653815372, 5272.0, 4841.927371089437, 4842.709437433765, 4866.489018653061, 4874.36708702585, 4884.241672997718, 5388.568914486871, 5516.475934786189, 5533.0, 5621.353544342412, 5642.520385767215, 4051.372037334218, 4070.653994410479, 4116.567760385146, 4177.728447650893, 4231.682623803196, 5666.121751128581, 5776.797812076557, 5792.7972520961985, 5808.9793307480295, 5820.729915333023, 4097.672186225095, 4157.792110394468, 4192.224438478891, 4221.451211342506, 4254.361845723104, 4208.431861698693, 4261.914761704748, 4271.807768650418, 4281.186574550826, 4290.270653988767, 4861.927071093936, 4885.5847252983895, 4901.460839307673, 4913.287573301923, 4922.458529561745, 5624.240727501735, 5643.746031428595, 5644.096944488862, 5649.406812284733, 5654.264945557051, 1447.768357062886, 1506.367325723199, 1512.8033355663692, 1518.2105305241212, 1523.1242035829443, 974.5273542331963, 977.9755506112405, 1006.8288390973552, 1009.0817356205818, 1014.9949250253701, 4879.0, 4901.485344038824, 4944.25593795447, 4960.950390496048, 4990.700557966534, 5132.5893928486375, 5165.966806638612, 5187.106706052339, 5199.142141546678, 5204.947950520446, 4788.25782003783, 4856.223004319362, 4959.528844759742, 4990.476000020019, 5022.547970682583, 2735.5076086304257, 2760.323720688404, 2770.4320614274025, 2778.4859800936892, 2811.6344875166096, 5334.759935802898, 5344.893102137936, 5348.839534813962, 5393.30111015029, 5398.379186393537, 5073.883745575968, 5194.298769666047, 5218.66078704883, 5221.216817477409, 5293.232481290268, 5304.946950530445, 5364.873376590882, 5391.843262694953, 5819.6614778600315, 5985.0, 5775.220345253337, 5796.029350021013, 5824.650520968756, 5828.650280982985, 5835.591508594358, 5700.885982280248, 5712.571557133315, 5714.542836572981, 5754.913676294943, 5757.827265182052, 5806.970965145148, 6034.094885766995, 6055.122007308827, 6058.848528786815, 6066.332703402711, 4288.571142885687, 4308.612224899774, 4325.74045557255, 4327.961289290484, 4328.696991210585, 5656.179853921076, 5711.3431955324, 5807.780366123162, 5814.273215848019, 5820.621659592113, 5599.468050535193, 5600.43995600453, 5631.915521267266, 5653.773849045992, 5675.290588676416, 5551.666899986014, 5642.379338272869, 5671.625382897169, 5682.147677848356, 5697.857553561028, 5260.658057226268, 5614.29821272341, 5620.74706638194, 5643.7742490299925, 5648.333741546336, 5722.370539240764, 5730.627509211888, 5741.511971482304, 5746.339170995389, 5757.309122905278, 5507.807226747044, 5614.831555053355, 5637.689927054052, 5637.9718101409235, 5661.980843448054], "value": 4268.2836342537, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.5081822224662, 810.3517186250998, 844.674800201922, 863.9049704532504, 939.5537119868061, 14666.413343466274, 14688.999999999987, 14733.0, 15729.37082516698, 18065.81934180658, 17156.485305440827, 17287.0, 17384.0, 17425.0, 17430.738538921894, 731.2650785960103, 869.5652173913044, 872.0189786490198, 877.1228771228771, 877.8814859993915, 852.4629483425433, 875.3478658399501, 882.0, 883.7216276872797, 884.3146561414891, 898.3980732908967, 904.317240483434, 904.5115637555712, 905.3888625178012, 913.3469569257979, 748.2218492767515, 767.2787579675088, 896.9641214351418, 897.1970086772335, 897.9461232326049, 570.1447828257614, 652.3378770547897, 670.7149461478851, 673.5419914458166, 681.9352161544646, 16574.337026518926, 16602.83397166025, 16607.750883736753, 16634.58413539659, 16660.58348541284, 14523.927380363137, 15055.924720376437, 15117.54647360581, 15134.470293539673, 15234.0, 13974.58076257714, 14314.42742290307, 14469.855301446956, 14479.855201447956, 14815.777763333559, 4756.167670657655, 4786.473487916326, 4815.614750819961, 4828.686135401223, 4838.225883858566, 80242.59878700628, 80501.59749201275, 80523.59738201271, 80546.0, 81395.5930220351, 11176.329420234812, 11286.435678216056, 11333.716657083638, 11736.471858766376, 11957.28256304607, 21318.467038324165, 21424.571508570054, 21424.892875535523, 21479.570408591742, 21480.355589332346, 8499.447535910145, 8554.315654747605, 8625.13748625145, 8642.0, 8657.39398242117, 4719.976400117977, 4749.3588365570895, 4820.3492528508905, 4890.804367825247, 5069.746512674352, 3681.1901381695984, 3874.7481413708583, 3885.048163200034, 3909.7263191576317, 3914.041059940333, 618.3877960818756, 623.8627501949563, 629.471244154912, 639.6929473852484, 644.0210879463283, 683.5625199872086, 697.5047716121509, 700.7477308169055, 706.9151701795818, 726.7674344209908, 9506.90493095074, 9634.0, 9668.661596844076, 9719.951400242953, 9809.166220871306, 608.984775380619, 674.2448457727377, 687.9036934829128, 695.6382681005848, 703.3880523944201, 4465.218586747306, 4545.114152059632, 4559.726416415026, 4654.86035418938, 4698.976505117453, 118088.40955795166, 119491.0, 119644.0, 119903.0, 121968.39015804864, 67883.66058169777, 78743.0, 100050.4997475008, 102239.488802557, 104560.0, 88464.0, 89230.0, 89550.0, 89590.55204724065, 89835.10164898398, 9109.863352049857, 9176.0, 9258.95370523143, 9314.813703726024, 9429.905700942903, 53998.73000634972, 54438.727806360715, 54684.453155467934, 55261.0, 56146.71926640341, 53233.0, 78202.6089869547, 78922.6053869727, 79094.20905790868, 79256.0, 11443.942780286377, 11749.118816088656, 12455.750884982432, 12486.319818896847, 12489.500419983098, 13295.734085318432, 13370.933145334211, 13566.118202317213, 13615.25116118623, 13822.308884555932, 12196.451159697657, 12409.0, 12848.871511284768, 13009.609711708665, 13136.408861601441, 14635.634109147357, 14873.256337183315, 15137.545873623809, 15212.46756363522, 15252.237388130327, 13940.0, 14040.578782636538, 14150.504732334319, 14354.784678230044, 14819.110853348833, 11402.0, 11458.71353216143, 11513.172652725572, 11547.595834146101, 11566.826497602375, 11592.130590205938, 11734.295942243492, 11824.527018919147, 11877.22798018126, 12131.878681213075], "value": 7809.716688832799, "unit": "score"}], "name": "dromaeo_css", "value": 7457.977709031968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 112.0, 110.0, 109.0, 108.0, 108.0, 111.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 128.0, 180.0, 125.0, 128.0, 153.0, 125.0, 156.0, 130.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 159.0, 160.0, 159.0, 159.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 125.0, 75.0, 76.0, 75.0, 74.0, 106.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 115.0, 85.0, 84.0, 85.0, 119.0, 84.0, 84.0, 123.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 192.0, 147.0, 147.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 52.0, 51.0, 52.0, 52.0, 51.0, 51.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 76.0, 76.0, 77.0, 79.0, 83.0, 77.0, 104.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 118.0, 115.0, 119.0, 121.0, 117.0, 118.0, 129.0, 119.0], "value": 119.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 154.0, 155.0, 155.0, 152.0, 152.0, 156.0, 152.0, 155.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 60.0, 60.0, 62.0, 61.0, 60.0, 59.0, 62.0, 61.0], "value": 60.9, "unit": "score"}], "name": "kraken", "value": 1474.8, "alertThreshold": 2.0}]} 06:38:43 INFO - Return code: 0 06:38:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:38:43 ERROR - # TBPL SUCCESS # 06:38:43 INFO - Running post-action listener: _resource_record_post_action 06:38:43 INFO - ##### 06:38:43 INFO - ##### Finished run-tests step (success) 06:38:43 INFO - ##### 06:38:43 INFO - Running post-run listener: _resource_record_post_run 06:38:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 376041472; Read time: 8; Write time: 220468 06:38:43 INFO - TinderboxPrint: CPU usage
13.1% 06:38:43 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 8 06:38:43 INFO - TinderboxPrint: I/O write bytes / time
376,041,472 / 220,468 06:38:43 INFO - TinderboxPrint: CPU idle
8,247.2 (86.9%) 06:38:43 INFO - TinderboxPrint: CPU user
1,201.1 (12.7%) 06:38:43 INFO - TinderboxPrint: Swap in / out
0 / 0 06:38:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114331648; Read time: 0; Write time: 87892 06:38:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 256442368; Read time: 8; Write time: 132120 06:38:44 INFO - Running post-run listener: _upload_blobber_files 06:38:44 INFO - Blob upload gear active. 06:38:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:44 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 06:38:44 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:38:44 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:38:44 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:48 INFO - (blobuploader) - INFO - Done attempting. 06:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:49 INFO - (blobuploader) - INFO - Done attempting. 06:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:49 INFO - (blobuploader) - INFO - Done attempting. 06:38:49 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:49 INFO - Return code: 0 06:38:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5ebe456f91a454021458093ca3eaee2b2e0ff0aadbee0ee8f7be0b1fd7acca9945c6547252c3961695c3751f82d1f4c58107dc5aaf4f9fb93f3f52a05d84f0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0c1fe36348f4ac7a9146035a8c003ce6eb57775fbb45abf14d50a45e29de6e54a9b1407ccf2de23dd7b19f4076e4eaa23679af670e54fccd853d871cfc1051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5259537e953a36a1e4532dad63e2a02bc2cc71e5456442eda9dcb2950c40742539828eb7bb5bfa1f8f380b92bda99bebd6efd945eee35a8254f99a696dd42b5"} 06:38:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:49 INFO - Contents: 06:38:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5ebe456f91a454021458093ca3eaee2b2e0ff0aadbee0ee8f7be0b1fd7acca9945c6547252c3961695c3751f82d1f4c58107dc5aaf4f9fb93f3f52a05d84f0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0c1fe36348f4ac7a9146035a8c003ce6eb57775fbb45abf14d50a45e29de6e54a9b1407ccf2de23dd7b19f4076e4eaa23679af670e54fccd853d871cfc1051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5259537e953a36a1e4532dad63e2a02bc2cc71e5456442eda9dcb2950c40742539828eb7bb5bfa1f8f380b92bda99bebd6efd945eee35a8254f99a696dd42b5"} 06:38:49 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:49 INFO - Copying logs to upload dir... 06:38:49 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.120702 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-25 06:38:49.838805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:49.843110) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5ebe456f91a454021458093ca3eaee2b2e0ff0aadbee0ee8f7be0b1fd7acca9945c6547252c3961695c3751f82d1f4c58107dc5aaf4f9fb93f3f52a05d84f0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0c1fe36348f4ac7a9146035a8c003ce6eb57775fbb45abf14d50a45e29de6e54a9b1407ccf2de23dd7b19f4076e4eaa23679af670e54fccd853d871cfc1051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5259537e953a36a1e4532dad63e2a02bc2cc71e5456442eda9dcb2950c40742539828eb7bb5bfa1f8f380b92bda99bebd6efd945eee35a8254f99a696dd42b5"} build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5ebe456f91a454021458093ca3eaee2b2e0ff0aadbee0ee8f7be0b1fd7acca9945c6547252c3961695c3751f82d1f4c58107dc5aaf4f9fb93f3f52a05d84f0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0c1fe36348f4ac7a9146035a8c003ce6eb57775fbb45abf14d50a45e29de6e54a9b1407ccf2de23dd7b19f4076e4eaa23679af670e54fccd853d871cfc1051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5259537e953a36a1e4532dad63e2a02bc2cc71e5456442eda9dcb2950c40742539828eb7bb5bfa1f8f380b92bda99bebd6efd945eee35a8254f99a696dd42b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:49.873492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:49.873830) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469451215.650759-1191660022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:49.956692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:38:49.957032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:38:49.957395) ========= ========= Total master_lag: 0.19 =========